[asterisk-r2] openR2 - falha em algumas ligaçoes

Moises Silva moises.silva at gmail.com
Wed Nov 5 13:30:29 CST 2008 

It seems what you are getting is just a metering pulse, that is, the
other end sends a clear backward (hangup) but immediately send answer
again. All you need to do to fix this is enable metering pulses in
your zapata.conf configuration:

mfcr2_metering_pulse_timeout=500

Let me know whether or not works.

Moisés Silva

On Wed, Nov 5, 2008 at 11:59 AM, Joao Carlos Moura <jmoura at crdusa.net> wrote:
> Hi all
> follow the suggestion of most previous emails did not work. The calls are
> still coming down after 2 minutes.
> The log below shows the error at the time off.
> I count on the help of you to resolve this issue.
>
> Log
> Asterisk 1.4.22 built by root @ pop2 on a i686 running Linux on 2008-10-29
> 14:52:59 UTC
> [Nov  5 14:46:53] DEBUG[17285] chan_dahdi.c: bits changed in chan 1
> [Nov  5 14:46:53] DEBUG[17285] chan_dahdi.c: Chan 1 - Bits changed from 0x04
> to 0x0C
> [Nov  5 14:46:53] DEBUG[17285] chan_dahdi.c: Chan 1 - ABCD Rx << [CLEAR
> BACK] 0x0C
> [Nov  5 14:46:53] NOTICE[17285] chan_dahdi.c: Chan 1 - Far end disconnected.
> Reason: Normal Clearing
> [Nov  5 14:46:53] NOTICE[17285] chan_dahdi.c: MFC/R2 call disconnected on
> chan 1
> [Nov  5 14:46:53] DEBUG[17285] chan_dahdi.c: disconnecting MFC/R2 call on
> chan 1
> [Nov  5 14:46:53] DEBUG[17285] chan_dahdi.c: Chan 1 - ABCD Tx >> [CLEAR
> FORWARD] 0x08
> [Nov  5 14:46:53] DEBUG[17285] chan_dahdi.c: Chan 1 - ABCD Raw Tx >> 0x09
> [Nov  5 14:46:53] DEBUG[17275] chan_dahdi.c: Chan 1 - Bits changed from 0x0C
> to 0x04
> [Nov  5 14:46:53] DEBUG[17275] chan_dahdi.c: Chan 1 - ABCD Rx << [0x04] 0x04
> [Nov  5 14:46:53] ERROR[17275] chan_dahdi.c: Chan 1 - Protocol error. Reason
> = Invalid CAS, R2 State = Clear Forward Transmitted, MF state = MF Engine
> Off, MF Group = Forward Group II, CAS = 0x04
> DNIS = 21274010, ANI = 36524800, MF = 0x20
>
> [Nov  5 14:50:53] DEBUG[17275] chan_dahdi.c: Chan 4 - ABCD Tx >> [IDLE] 0x08
> [Nov  5 14:50:53] DEBUG[17275] chan_dahdi.c: Chan 4 - ABCD Raw Tx >> 0x09
> [Nov  5 14:50:53] ERROR[17275] chan_dahdi.c: MFC/R2 protocol error on chan
> 4: Invalid CAS
> [Nov  5 14:50:53] DEBUG[17275] chan_dahdi.c: Chan 4 - Bits changed from 0x04
> to 0x08
> [Nov  5 14:50:53] DEBUG[17275] chan_dahdi.c: Chan 4 - ABCD Rx << [IDLE] 0x08
> [Nov  5 14:50:53] NOTICE[17275] chan_dahdi.c: Far end unblocked on chan 4
> [Nov  5 14:50:53] DEBUG[17288] chan_dahdi.c: bits changed in chan 2
> [Nov  5 14:50:53] DEBUG[17288] chan_dahdi.c: Chan 2 - Bits changed from 0x04
> to 0x0C
> [Nov  5 14:50:53] DEBUG[17288] chan_dahdi.c: Chan 2 - ABCD Rx << [CLEAR
> BACK] 0x0C
> [Nov  5 14:50:53] NOTICE[17288] chan_dahdi.c: Chan 2 - Far end disconnected.
> Reason: Normal Clearing
> [Nov  5 14:50:53] NOTICE[17288] chan_dahdi.c: MFC/R2 call disconnected on
> chan 2
> [Nov  5 14:50:53] DEBUG[17288] chan_dahdi.c: disconnecting MFC/R2 call on
> chan 2
> [Nov  5 14:50:53] DEBUG[17288] chan_dahdi.c: Chan 2 - ABCD Tx >> [CLEAR
> FORWARD] 0x08
> [Nov  5 14:50:53] DEBUG[17288] chan_dahdi.c: Chan 2 - ABCD Raw Tx >> 0x09
> [Nov  5 14:50:53] DEBUG[17275] chan_dahdi.c: Chan 2 - Bits changed from 0x0C
> to 0x04
> [Nov  5 14:50:53] DEBUG[17275] chan_dahdi.c: Chan 2 - ABCD Rx << [0x04] 0x04
> [Nov  5 14:50:53] ERROR[17275] chan_dahdi.c: Chan 2 - Protocol error. Reason
> = Invalid CAS, R2 State = Clear Forward Transmitted, MF state = MF Engine
> Off, MF Group = Forward Group II, CAS = 0x04
> DNIS = 30844959, ANI = 36524800, MF = 0x20
>
> zaptel.conf
> span=1,1,0,cas,hdb3
> cas=1-15:1101
> dchan=16
> cas=17-31:1101
> loadzone = br
> defaultzone= br
>
> zapata.conf
> [channels]
> usecallerid=yes
> callwaiting=yes
> usecallingpres=yes
> callwaitingcallerid=yes
> threewaycalling=yes
> transfer=yes
> canpark=yes
> cancallforward=yes
> callreturn=yes
> echocancel=yes
> echotrainning=yes
> echocancelwhenbridged=yes
>
> signalling=mfcr2
> mfcr2_variant=br
> mfcr2_get_ani_first=yes
> mfcr2_max_ani=20
> mfcr2_max_dnis=20
> mfcr2_category=national_subscriber
> mfcr2_logdir=openr2
> mfcr2_call_files=no
> mfcr2_logging=all
>
> group=1
> callgroup=1
> pickupgroup=1
> callerid=asreceived
> context=from-pstn
>
> channel => 1-15,17-31
>
> sip.conf
> [POP1]
> type=friend
> insecure=very
> qualify=yes
> canreinvite=no
> host=192.168.0.5
> nat=yes
> dtmfmode=rfc2833
> disallow=all
> allow=ulaw
> context=to-pstn
>
> Openr2
> OpenR2 version: 0.1.1, revision: 95
>
> pop2*CLI> zap show status
> Description                              Alarms     IRQ        bpviol
> CRC4
> Digium Wildcard TE110P T1/E1 Card 0      OK         0          0          0
>
> pop2*CLI> core show version
> Asterisk 1.4.22 built by root @ pop2 on a i686 running Linux on 2008-11-05
> 18:41:00 UTC
>
> Thank's
> Joao Carlos
>
>
>
>
>
>
>
>
>
> ----- Original Message -----
> From: "Moises Silva" <moises.silva at gmail.com>
> To: <asterisk-r2 at lists.digium.com>
> Sent: Wednesday, November 05, 2008 2:18 PM
> Subject: Re: [asterisk-r2]openR2 - falha em algumas ligaçoes
>
>
> Take a good log with debug information, mfcr2_logging=all in
> chan_dahdi.conf/zapata.conf and debug enabled in Asterisk logger.conf
>
> Also make sure you recompiled both OpenR2 and Asterisk (in that order)
> after upgrading.
>
> On Wed, Nov 5, 2008 at 11:13 AM, Melcon Moraes <melcon at gmail.com> wrote:
>> Just to make sure, when you did the upgrade for libopenr2 @95, did you
>> upgrade your * to the latest revision as well?
>>
>> $> svn co http://svn.digium.com/svn/asterisk/team/moy/mfcr2-1.4
>> asterisk-1.4
>>
>> - MM
>>
>> On Tue, Nov 4, 2008 at 3:24 PM, Joao Carlos Moura <jmoura at crdusa.net>
>> wrote:
>>> Hi,
>>> thanks for the information.
>>> Upgraded the library openr2-79 for openr2-95.
>>> The problem of transmission of digits has declined significantly.
>>> Now I reported that after 5-6 minutes the call drops.
>>> Search information repository in the list did not find more.
>>> Is there a parameter to change and avoid this problem?
>>> I have a E1 30 channels with Oi-Brasil.
>>>
>>> Thank you
>>>
>>> ----- Original Message -----
>>> From: "Moises Silva" <moises.silva at gmail.com>
>>> To: <asterisk-r2 at lists.digium.com>
>>> Sent: Tuesday, November 04, 2008 11:56 AM
>>> Subject: Re: [asterisk-r2]openR2 - falha em algumas ligaçoes
>>>
>>>
>>> Indeed changing mfcr2_get_ani_first would not change nothing in this
>>> particular log we are seeing.
>>>
>>> The first thing you need to do is upgrade openr2 or it would be harder
>>> to help you, since you are about 15 revisions (changes to openr2)
>>> behind.
>>>
>>> The log is pretty clear,
>>>
>>> Nov  1 06:28:16] DEBUG[2771]: chan_dahdi.c:3170 dahdi_hangup
>>>
>>> in the middle of a call we're sending "Clear Forward" signal, and the
>>> only cause for that is that Asterisk requests the hangup. In this
>>> case, it seems the other leg of the bridge is a SIP channel. You would
>>> need to see with sip debug if they are sending us the hangup signal.
>>>
>>> How often does this happen?
>>>
>>> Moy
>>>
>>> On Tue, Nov 4, 2008 at 8:36 AM, Melcon Moraes <melcon at gmail.com> wrote:
>>>> When a call is being placed to the TELCO, you don't get ANI first or
>>>> after. You send it. How would that change matters in this case?
>>>>
>>>> -MM
>>>>
>>>> On Tue, Nov 4, 2008 at 11:57 AM, Alexandre Cavalcante Alencar
>>>> <alexandre.alencar at gmail.com> wrote:
>>>>> Hi all,
>>>>>
>>>>> João, can you change a param and check again?
>>>>>
>>>>> ; before
>>>>> mfcr2_get_ani_first=no
>>>>>
>>>>> ; after
>>>>> mfcr2_get_ani_first=yes
>>>>>
>>>>> As per [1], Oi (Telemar) get ANI digits first. And if you can, make the
>>>>> test
>>>>> using r2test so we can have a clean testbed.
>>>>>
>>>>> [1] http://www.soft-switch.org/unicall/installing-mfcr2.html
>>>>>
>>>>> Best Regards.
>>>>>
>>>>>
>>>>> On Tue, Nov 4, 2008 at 6:45 AM, Joao Carlos Moura <jmoura at crdusa.net>
>>>>> wrote:
>>>>>>
>>>>>> Olá pessoal, instalei o pacote OpenR2 em um servidor Debian 4.0-r5 com
>>>>>> asterisk 1.4.
>>>>>> Nao tive nenhum problema com compilação e aparentemente não acontece
>>>>>> nenhum erro.
>>>>>> O problema que enfrento é que em algumas ligações que não completam.
>>>>>> Habilitei o debug e verifiquei que no momento da falha, onde era para
>>>>>> enviar o número discado digito
>>>>>> por digito e pára no primeiro e fica até dar timeout.
>>>>>> Conversei com o Alexandre e ele me deu algumas sugestões, entre elas
>>>>>> atualizar o pacote.
>>>>>> Esse procedimento ainda nao fiz
>>>>>>
>>>>>> Envio minha configuração e um debug que falhou a chamada.
>>>>>> Agradeço a ajuda
>>>>>>
>>>>>> João Carlos Moura
>>>>>>
>>>>>> Debian
>>>>>> Asterisk 1.4.22
>>>>>> OpenR2 version: 0.1.1, revision: 79
>>>>>>
>>>>>> zapata.conf
>>>>>> [channels]
>>>>>> usecallerid=yes
>>>>>> callwaiting=yes
>>>>>> usecallingpres=yes
>>>>>> callwaitingcallerid=yes
>>>>>> threewaycalling=yes
>>>>>> transfer=yes
>>>>>> canpark=yes
>>>>>> cancallforward=yes
>>>>>> callreturn=yes
>>>>>> echocancel=yes
>>>>>> echotrainning=yes
>>>>>> echocancelwhenbridged=yes
>>>>>>
>>>>>> signalling=mfcr2
>>>>>> mfcr2_variant=br
>>>>>> mfcr2_get_ani_first=no
>>>>>> mfcr2_max_ani=20
>>>>>> mfcr2_max_dnis=20
>>>>>> mfcr2_category=national_subscriber
>>>>>> mfcr2_logdir=span1
>>>>>> mfcr2_logging=all
>>>>>>
>>>>>> group=1
>>>>>> callgroup=1
>>>>>> pickupgroup=1
>>>>>> callerid=asreceived
>>>>>> context=from-pstn
>>>>>>
>>>>>> channel => 1-15,17-31
>>>>>> zaptel.conf                              ;  E1 da Oi
>>>>>> span=1,1,0,cas,hdb3
>>>>>> cas=1-15:1101
>>>>>> dchan=16
>>>>>> cas=17-31:1101
>>>>>> loadzone = br
>>>>>> defaultzone= br
>>>>>>
>>>>>> Debug que falhou a chamada
>>>>>>
>>>>>>     -- Executing [POP121211724 at to-pstn:1]
>>>>>> SetCDRUserField("SIP/192.168.0.5-b7000480", "POP121211724") in new
>>>>>> stack
>>>>>>     -- Executing [POP121211724 at to-pstn:2]
>>>>>> Dial("SIP/192.168.0.5-b7000480",
>>>>>> "ZAP/g1/21211724|60|Ct") in new stack
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:956
>>>>>> dahdi_r2_get_channel_category: no MFC/R2 category specified for chan
>>>>>> Zap/1-1, using default National Subscriber
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - Attempting to make call (ANI=9009, DNIS=21211724,
>>>>>> category=National
>>>>>> Subscriber)
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Tx >> [SEIZE] 0x00
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Raw Tx >> 0x01
>>>>>>     -- Called g1/21211724
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:4370 dahdi_handle_event:
>>>>>> bits
>>>>>> changed in chan 1
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - Bits changed from 0x08 to 0x0C
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Rx << [SEIZE ACK] 0x0C
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - Sending DNIS digit 2
>>>>>> [Nov  1 06:28:10] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - MF Tx >> 2 [ON]
>>>>>> [Nov  1 06:28:16] DEBUG[2771]: chan_dahdi.c:3170 dahdi_hangup:
>>>>>> disconnecting MFC/R2 call on chan 1
>>>>>> [Nov  1 06:28:16] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Tx >> [CLEAR FORWARD] 0x08
>>>>>> [Nov  1 06:28:16] DEBUG[2771]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Raw Tx >> 0x09
>>>>>>     -- Hungup 'Zap/1-1'
>>>>>>   == Spawn extension (to-pstn, POP121211724, 2) exited non-zero on
>>>>>> 'SIP/192.168.0.5-b7000480'
>>>>>> [Nov  1 06:28:16] DEBUG[2636]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - Bits changed from 0x0C to 0x08
>>>>>> [Nov  1 06:28:16] DEBUG[2636]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Rx << [IDLE] 0x08
>>>>>> [Nov  1 06:28:16] DEBUG[2636]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - Call ended
>>>>>> [Nov  1 06:28:16] DEBUG[2636]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Tx >> [IDLE] 0x08
>>>>>> [Nov  1 06:28:16] DEBUG[2636]: chan_dahdi.c:1209 dahdi_r2_write_log:
>>>>>> Chan
>>>>>> 1 - ABCD Raw Tx >> 0x09
>>>>>> [Nov  1 06:28:16] NOTICE[2636]: chan_dahdi.c:1065
>>>>>> dahdi_r2_on_call_end:
>>>>>> MFC/R2 call en
>>>>>> ________________________________
>>>>>> I am using the Free version of SPAMfighter
>>>>>> We are a community of 5.6 million users fighting spam.
>>>>>> SPAMfighter has removed 32904 of my spam emails to date.
>>>>>> The Professional version does not have this message
>>>>>>
>>>>>> _______________________________________________
>>>>>> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>>>>>>
>>>>>> asterisk-r2 mailing list
>>>>>> To UNSUBSCRIBE or update options visit:
>>>>>>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>>>>>
>>>>>
>>>>>
>>>>> --
>>>>> Alexandre C Alencar (Skarmeth)
>>>>> http://blog.alexandrealencar.net/
>>>>> http://www.alexandrealencar.net/
>>>>> http://people.debian-ce.org/skarmeth/
>>>>>
>>>>>
>>>>> _______________________________________________
>>>>> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>>>>>
>>>>> asterisk-r2 mailing list
>>>>> To UNSUBSCRIBE or update options visit:
>>>>>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>>>>>
>>>> _______________________________________________
>>>> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>>>>
>>>> asterisk-r2 mailing list
>>>> To UNSUBSCRIBE or update options visit:
>>>>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>>>
>>>
>>>
>>> --
>>> "I do not agree with what you have to say, but I'll defend to the
>>> death your right to say it." Voltaire
>>>
>>> _______________________________________________
>>> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>>>
>>> asterisk-r2 mailing list
>>> To UNSUBSCRIBE or update options visit:
>>>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>>>
>>>
>>> --
>>> I am using the free version of SPAMfighter.
>>> We are a community of 5.6 million users fighting spam.
>>> SPAMfighter has removed 32924 of my spam emails to date.
>>> Get the free SPAMfighter here: http://www.spamfighter.com/len
>>>
>>> The Professional version does not have this message
>>>
>>>
>>>
>>> _______________________________________________
>>> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>>>
>>> asterisk-r2 mailing list
>>> To UNSUBSCRIBE or update options visit:
>>>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>>>
>> _______________________________________________
>> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>>
>> asterisk-r2 mailing list
>> To UNSUBSCRIBE or update options visit:
>>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>
>
>
> --
> "I do not agree with what you have to say, but I'll defend to the
> death your right to say it." Voltaire
>
> _______________________________________________
> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>
> asterisk-r2 mailing list
> To UNSUBSCRIBE or update options visit:
>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>
>
> --
> I am using the free version of SPAMfighter.
> We are a community of 5.6 million users fighting spam.
> SPAMfighter has removed 33003 of my spam emails to date.
> Get the free SPAMfighter here: http://www.spamfighter.com/len
>
> The Professional version does not have this message
>
>
>
> _______________________________________________
> --Bandwidth and Colocation Provided by http://www.api-digital.com--
>
> asterisk-r2 mailing list
> To UNSUBSCRIBE or update options visit:
>   http://lists.digium.com/mailman/listinfo/asterisk-r2
>



-- 
"I do not agree with what you have to say, but I'll defend to the
death your right to say it." Voltaire

More information about the asterisk-r2 mailing list