[asterisk-r2] Hang up after 5 to 10 minutes of call

Wed Oct 5 17:07:12 CDT 2016

Hi everybody!

Long time without writting, hope everyone is doing fine.

I have a customer with a full E1 working "fine", calls can be received and
placed. The only problem is a random hangout of an ongoing call between 5
to 10 minutes. It does not matter if the call is inbound or outbound.

The service provider is using audiocodes at the other end.

signalling=mfcr2
mfcr2_variant=mx
mfcr2_get_ani_first=no
mfcr2_max_ani=10
mfcr2_max_dnis=4
mfcr2_category=national_subscriber
mfcr2_call_files=yes
mfcr2_logdir=span1
mfcr2_logging=all
mfcr2_allow_collect_calls=yes
mfcr2_mfback_timeout=-1
mfcr2_metering_pulse_timeout=-1
group=1
context=from-zaptel
channel => 1-15,17-31

As far as I can see in the following trace, our pbx is hanging up the call.
¿Could you please double check if i am missing something?

[16:20:03:619] [Thread: 140242963814144] [Chan 1] - Call started at Wed Sep
21 16:20:03 2016 on chan 1 [openr2 version 1.3.3, revision (release)]
[16:20:03:619] [Thread: 140242963814144] [Chan 1] - Outgoing call
proceeding: ANI=2188, DNIS=0445527046779, Category=National Subscriber
[16:20:03:619] [Thread: 140242963814144] [Chan 1] - CAS Tx >> [SEIZE] 0x00
[16:20:03:619] [Thread: 140242963814144] [Chan 1] - CAS Raw Tx >> 0x01
[16:20:03:619] [Thread: 140242963814144] [Chan 1] - scheduled timer id 2
(r2_seize)
[16:20:03:727] [Thread: 140242963814144] [Chan 1] - Bits changed from 0x08
to 0x0C
[16:20:03:727] [Thread: 140242963814144] [Chan 1] - CAS Rx << [SEIZE ACK]
0x0C
[16:20:03:727] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 2
[16:20:03:727] [Thread: 140242963814144] [Chan 1] - timer id 2 found,
cancelling it now
[16:20:03:727] [Thread: 140242963814144] [Chan 1] - MFC/R2 call acknowledge!
[16:20:03:727] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 0
[16:20:03:727] [Thread: 140242963814144] [Chan 1] - MF Tx >> 0 [ON]
[16:20:03:838] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:03:838] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:03:838] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:03:838] [Thread: 140242963814144] [Chan 1] - MF Tx >> 0 [OFF]
[16:20:03:938] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:03:938] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 4
[16:20:03:938] [Thread: 140242963814144] [Chan 1] - MF Tx >> 4 [ON]
[16:20:03:938] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:04:038] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:04:038] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:04:038] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:04:038] [Thread: 140242963814144] [Chan 1] - MF Tx >> 4 [OFF]
[16:20:04:118] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:04:118] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 4
[16:20:04:118] [Thread: 140242963814144] [Chan 1] - MF Tx >> 4 [ON]
[16:20:04:118] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:04:238] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:04:238] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:04:238] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:04:238] [Thread: 140242963814144] [Chan 1] - MF Tx >> 4 [OFF]
[16:20:04:338] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:04:338] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 5
[16:20:04:338] [Thread: 140242963814144] [Chan 1] - MF Tx >> 5 [ON]
[16:20:04:338] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:04:478] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:04:478] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:04:478] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:04:478] [Thread: 140242963814144] [Chan 1] - MF Tx >> 5 [OFF]
[16:20:04:578] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:04:578] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 5
[16:20:04:578] [Thread: 140242963814144] [Chan 1] - MF Tx >> 5 [ON]
[16:20:04:578] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:04:698] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:04:698] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:04:698] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:04:698] [Thread: 140242963814144] [Chan 1] - MF Tx >> 5 [OFF]
[16:20:04:818] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:04:818] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 2
[16:20:04:818] [Thread: 140242963814144] [Chan 1] - MF Tx >> 2 [ON]
[16:20:04:818] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:04:938] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:04:938] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:04:939] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:04:939] [Thread: 140242963814144] [Chan 1] - MF Tx >> 2 [OFF]
[16:20:05:038] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:05:038] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 7
[16:20:05:038] [Thread: 140242963814144] [Chan 1] - MF Tx >> 7 [ON]
[16:20:05:038] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:05:178] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:05:178] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:05:178] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:05:178] [Thread: 140242963814144] [Chan 1] - MF Tx >> 7 [OFF]
[16:20:05:298] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:05:298] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 0
[16:20:05:298] [Thread: 140242963814144] [Chan 1] - MF Tx >> 0 [ON]
[16:20:05:298] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:05:418] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:05:418] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:05:418] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:05:418] [Thread: 140242963814144] [Chan 1] - MF Tx >> 0 [OFF]
[16:20:05:538] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:05:538] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 4
[16:20:05:538] [Thread: 140242963814144] [Chan 1] - MF Tx >> 4 [ON]
[16:20:05:538] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:05:678] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:05:678] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:05:678] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:05:678] [Thread: 140242963814144] [Chan 1] - MF Tx >> 4 [OFF]
[16:20:05:798] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:05:798] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 6
[16:20:05:798] [Thread: 140242963814144] [Chan 1] - MF Tx >> 6 [ON]
[16:20:05:798] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:05:918] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:05:918] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:05:918] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:05:918] [Thread: 140242963814144] [Chan 1] - MF Tx >> 6 [OFF]
[16:20:06:038] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:06:038] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 7
[16:20:06:038] [Thread: 140242963814144] [Chan 1] - MF Tx >> 7 [ON]
[16:20:06:038] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:06:158] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:06:158] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:06:158] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:06:158] [Thread: 140242963814144] [Chan 1] - MF Tx >> 7 [OFF]
[16:20:06:258] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:06:258] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 7
[16:20:06:258] [Thread: 140242963814144] [Chan 1] - MF Tx >> 7 [ON]
[16:20:06:258] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:06:378] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:06:378] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:06:378] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:06:378] [Thread: 140242963814144] [Chan 1] - MF Tx >> 7 [OFF]
[16:20:06:478] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:06:478] [Thread: 140242963814144] [Chan 1] - Sending DNIS digit 9
[16:20:06:478] [Thread: 140242963814144] [Chan 1] - MF Tx >> 9 [ON]
[16:20:06:478] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:06:598] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:06:598] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:06:598] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:06:598] [Thread: 140242963814144] [Chan 1] - MF Tx >> 9 [OFF]
[16:20:06:718] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:06:718] [Thread: 140242963814144] [Chan 1] - No more DNIS. Doing
nothing, waiting for timeout.
[16:20:06:718] [Thread: 140242963814144] [Chan 1] - scheduled timer id 3
(mf_fwd_safety)
[16:20:06:718] [Thread: 140242963814144] [Chan 1] - Group A DNIS request
handled
[16:20:14:758] [Thread: 140242963814144] [Chan 1] - MF Rx << 3 [ON]
[16:20:14:758] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 3
[16:20:14:758] [Thread: 140242963814144] [Chan 1] - timer id 3 found,
cancelling it now
[16:20:14:858] [Thread: 140242963814144] [Chan 1] - MF Rx << 3 [OFF]
[16:20:14:858] [Thread: 140242963814144] [Chan 1] - Sending category
National Subscriber
[16:20:14:858] [Thread: 140242963814144] [Chan 1] - MF Tx >> 1 [ON]
[16:20:19:118] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [ON]
[16:20:19:118] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:19:118] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:20:19:118] [Thread: 140242963814144] [Chan 1] - MF Tx >> 1 [OFF]
[16:20:19:218] [Thread: 140242963814144] [Chan 1] - MF Rx << 1 [OFF]
[16:20:19:218] [Thread: 140242963814144] [Chan 1] - scheduled timer id 4
(r2_answer)
[16:20:22:585] [Thread: 140242963814144] [Chan 1] - Bits changed from 0x0C
to 0x04
[16:20:22:585] [Thread: 140242963814144] [Chan 1] - CAS Rx << [ANSWER] 0x04
[16:20:22:585] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 4
[16:20:22:585] [Thread: 140242963814144] [Chan 1] - timer id 4 found,
cancelling it now
[16:20:22:585] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:20:22:585] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:32:18:053] [Thread: 140242963814144] [Chan 1] - Attempting to cancel
timer timer 0
[16:32:18:053] [Thread: 140242963814144] [Chan 1] - Cannot cancel timer 0
[16:32:18:053] [Thread: 140242963814144] [Chan 1] - CAS Tx >> [CLEAR
FORWARD] 0x08
[16:32:18:053] [Thread: 140242963814144] [Chan 1] - CAS Raw Tx >> 0x09
[16:32:18:153] [Thread: 140243702339328] [Chan 1] - Bits changed from 0x04
to 0x08
[16:32:18:153] [Thread: 140243702339328] [Chan 1] - CAS Rx << [IDLE] 0x08
[16:32:18:153] [Thread: 140243702339328] [Chan 1] - Call ended
[16:32:18:153] [Thread: 140243702339328] [Chan 1] - Attempting to cancel
timer timer 0
[16:32:18:153] [Thread: 140243702339328] [Chan 1] - Cannot cancel timer 0

Thank you guys!

León Ramos,
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.digium.com/pipermail/asterisk-r2/attachments/20161005/f522fac2/attachment.html>