[asterisk-r2] openR2 drop calls

Fri Apr 17 15:08:49 CDT 2009

Who is on the other side of the call?

We're receiving hangup (CLEAR FORWARD) from the other side of the R2
connection. I have seen metering pulses from the backward side, but
not from the forward side, I may need to add metering pulse for both
sides.

Are you sure the calling party is not hanging up?

Moy

On Fri, Apr 17, 2009 at 3:47 PM, Rubens Lacerda Almeida
<rubens at totvs.com.br> wrote:
> Hi all,
>
>
>
> I’m Brazilian and I study English yet and forgive my worst English. So, I
> have tested openR2 and my received calls is dropping. In error log, I have
> the following:
>
>
>
> [11:52:05:755] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [ON]
>
> [11:52:05:755] [Thread: 3070852016] [Chan 29] - scheduled timer id 14
> (mf_back_cycle)
>
> [11:52:05:815] [Thread: 3070852016] [Chan 29] - MF Rx << F [OFF]
>
> [11:52:05:815] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [OFF]
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - MF Rx << 3 [ON]
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - Attempting to cancel timer
> timer 14
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - timer id 14 found,
> cancelling it now
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - Getting DNIS digit 3
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - DNIS so far: 73, expected
> length: 20
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - Requesting next DNIS with
> signal 0x31.
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [ON]
>
> [11:52:05:895] [Thread: 3070852016] [Chan 29] - scheduled timer id 15
> (mf_back_cycle)
>
> [11:52:05:975] [Thread: 3070852016] [Chan 29] - MF Rx << 3 [OFF]
>
> [11:52:05:975] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [OFF]
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - MF Rx << 2 [ON]
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - Attempting to cancel timer
> timer 15
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - timer id 15 found,
> cancelling it now
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - Getting DNIS digit 2
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - DNIS so far: 732, expected
> length: 20
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - Requesting next DNIS with
> signal 0x31.
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [ON]
>
> [11:52:06:035] [Thread: 3070852016] [Chan 29] - scheduled timer id 16
> (mf_back_cycle)
>
> [11:52:06:115] [Thread: 3070852016] [Chan 29] - MF Rx << 2 [OFF]
>
> [11:52:06:115] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [OFF]
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - MF Rx << 0 [ON]
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - Attempting to cancel timer
> timer 16
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - timer id 16 found,
> cancelling it now
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - Getting DNIS digit 0
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - DNIS so far: 7320, expected
> length: 20
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - User requested us to stop
> getting DNIS!
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - Requesting change to Group
> II with signal 0x33
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - MF Tx >> 3 [ON]
>
> [11:52:06:175] [Thread: 3070852016] [Chan 29] - scheduled timer id 17
> (mf_back_cycle)
>
> [11:52:06:255] [Thread: 3070852016] [Chan 29] - MF Rx << 0 [OFF]
>
> [11:52:06:255] [Thread: 3070852016] [Chan 29] - MF Tx >> 3 [OFF]
>
> [11:52:06:315] [Thread: 3070852016] [Chan 29] - MF Rx << 1 [ON]
>
> [11:52:06:315] [Thread: 3070852016] [Chan 29] - Attempting to cancel timer
> timer 17
>
> [11:52:06:315] [Thread: 3070852016] [Chan 29] - timer id 17 found,
> cancelling it now
>
> [11:52:06:315] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [ON]
>
> [11:52:06:315] [Thread: 3070852016] [Chan 29] - scheduled timer id 18
> (mf_back_cycle)
>
> [11:52:06:395] [Thread: 3070852016] [Chan 29] - MF Rx << 1 [OFF]
>
> [11:52:06:395] [Thread: 3070852016] [Chan 29] - MF Tx >> 1 [OFF]
>
> [11:52:06:395] [Thread: 3070852016] [Chan 29] - Attempting to cancel timer
> timer 18
>
> [11:52:06:395] [Thread: 3070852016] [Chan 29] - timer id 18 found,
> cancelling it now
>
> [11:52:06:395] [Thread: 3070852016] [Chan 29] - scheduled timer id 19
> (r2_answer_delay)
>
> [11:52:06:555] [Thread: 3070852016] [Chan 29] - Attempting to cancel timer
> timer 19
>
> [11:52:06:555] [Thread: 3070852016] [Chan 29] - timer id 19 found,
> cancelling it now
>
> [11:52:06:555] [Thread: 3070852016] [Chan 29] - calling timer 19
> (r2_answer_delay) callback
>
> [11:52:06:558] [Thread: 3069574064] [Chan 29] - CAS Tx >> [ANSWER] 0x04
>
> [11:52:06:558] [Thread: 3069574064] [Chan 29] - CAS Raw Tx >> 0x05
>
> [11:52:38:619] [Thread: 3069574064] [Chan 29] - Bits changed from 0x00 to
> 0x08
>
> [11:52:38:619] [Thread: 3069574064] [Chan 29] - CAS Rx << [CLEAR FORWARD]
> 0x08
>
> [11:52:38:619] [Thread: 3069574064] [Chan 29] - Far end disconnected.
> Reason: Normal Clearing
>
> [11:52:38:633] [Thread: 3069574064] [Chan 29] - Call ended
>
> [11:52:38:633] [Thread: 3069574064] [Chan 29] - Attempting to cancel timer
> timer 0
>
> [11:52:38:633] [Thread: 3069574064] [Chan 29] - Cannot cancel timer 0
>
>
>
> My configuration is that: AsteriskR2 à Asteriskchannels
>
>
>
> I receive the call in AsteriskR2 and I send this call for Asteriskchannels
> through IAX2. The Asteriskchannels look the specific channel and send the
> call for the correct user.
>
> I think who I don’t have problems with IAX2.. IAX2 don’t drop my call, see
> the asterisk log:
>
>
>
> [Apr 16 11:52:04] NOTICE[2772]: chan_dahdi.c:1023 dahdi_r2_on_call_init: New
> MFC/R2 call detected on chan 29.
>
> [Apr 16 11:52:06] NOTICE[2772]: chan_dahdi.c:1090 dahdi_r2_on_call_offered:
> MFC/R2 call offered on chan 29. ANI = 11XXXXXXXX, DNIS = XXXX, Category =
> National Subscriber
>
> [Apr 16 11:52:06] NOTICE[2772]: chan_dahdi.c:1153 dahdi_r2_on_call_accepted:
> MFC/R2 call has been accepted on chan 29
>
>     -- Executing [XXXX at e1:1] Set("Zap/29-1", "CALLERID(num)=11XXXXXXXX") in
> new stack
>
>     -- Executing [XXXX at e1:2] Dial("Zap/29-1",
> "IAX2/astpstnr2:XXXXXXX at nnnn.mmmm.dddd.zzzz/XXXX") in new stack
>
>     -- Called astpstnr2: :XXXXXXX at nnnn.mmmm.dddd.zzzz/XXXX
>
>     -- Call accepted by nnnn.mmmm.dddd.zzzz (format ulaw)
>
>     -- Format for call is ulaw
>
>     -- IAX2/ nnnn.mmmm.dddd.zzzz:4569-14305 answered Zap/29-1
>
>
>
> After
>
>
>
> [Apr 16 11:52:38] NOTICE[2939]: chan_dahdi.c:1288 dahdi_r2_write_log: Chan
> 29 - Far end disconnected. Reason: Normal Clearing
>
> [Apr 16 11:52:38] NOTICE[2939]: chan_dahdi.c:1223
> dahdi_r2_on_call_disconnect: MFC/R2 call disconnected on chan 29
>
>     -- Hungup 'IAX2/ nnnn.mmmm.dddd.zzzz:4569-14305'
>
>   == Spawn extension (e1, XXXX, 2) exited non-zero on 'Zap/29-1'
>
> [Apr 16 11:52:38] NOTICE[2939]: chan_dahdi.c:1142 dahdi_r2_on_call_end:
> MFC/R2 call end on chan 29
>
>     -- Hungup 'Zap/29-1'
>
>
>
> My zaptel conf
>
> span=1,1,0,cas,hdb3
>
> cas=1-15:1101
>
> dchan=16
>
> cas=17-31:1101
>
>
>
> loadzone = br
>
> defaultzone= br
>
>
>
> My Zapata.conf ( E1 Telefonica)
>
> [channels]
>
> usecallerid=yes
>
> callwaiting=yes
>
> usecallingpres=yes
>
> callwaitingcallerid=yes
>
> threewaycalling=yes
>
> transfer=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=yes
>
> mfcr2_logging=all
>
> mfcr2_metering_pulse_timeout=500
>
> ;
>
> group=1
>
> callerid=asreceived
>
> context=e1
>
>
>
> channel => 1-15,17-31
>
>
>
> Thanks,
>
>
>
> Rubens Almeida
>
>
>
> _______________________________________________
> --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