We’re suffering from an issue whereby calls randomly hangup, or terminate. This happens on incoming and outgoing calls, sometimes during a call, sometimes when being transferred. There’s no pattern I can see, but it appears to be getting worse with 2 reports last week and about 10 so far this week.
Other than the random hanging up, calls are working normally and sound great.
The asterisk server is running 1.8.
Here’s a log file of just one call. It looks like one of the parties initiated a hangup as normal, but neither party did. These looks the same as the other log examples I have here.
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] netsock2.c: == Using SIP RTP TOS bits 184
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] netsock2.c: == Using SIP RTP TOS bits 184
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] netsock2.c: == Using SIP RTP CoS mark 5
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] netsock2.c: == Using SIP RTP CoS mark 5
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] app_dial.c: – Called SIP/Trunk/
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] app_dial.c: – Called SIP/Trunk/
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] app_dial.c: – SIP/Trunk-00003d64 is making progress passing it to SIP/1036-00003d63
/var/log/asterisk/full-20130626:[2013-06-25 15:29:10] VERBOSE[23752] app_dial.c: – SIP/Trunk-00003d64 is making progress passing it to SIP/1036-00003d63
/var/log/asterisk/full-20130626:[2013-06-25 15:29:16] VERBOSE[23752] app_dial.c: – SIP/Trunk-00003d64 is ringing
/var/log/asterisk/full-20130626:[2013-06-25 15:29:16] VERBOSE[23752] app_dial.c: – SIP/Trunk-00003d64 is ringing
/var/log/asterisk/full-20130626:[2013-06-25 15:29:22] VERBOSE[23752] app_dial.c: – SIP/Trunk-00003d64 answered SIP/1036-00003d63
/var/log/asterisk/full-20130626:[2013-06-25 15:29:22] VERBOSE[23752] app_dial.c: – SIP/Trunk-00003d64 answered SIP/1036-00003d63
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [h@macro-dialout-trunk:1] Macro(“SIP/1036-00003d63”, “hangupcall,”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [h@macro-dialout-trunk:1] Macro(“SIP/1036-00003d63”, “hangupcall,”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/1036-00003d63”, “1?theend”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/1036-00003d63”, “1?theend”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Goto (macro-hangupcall,s,3)
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Goto (macro-hangupcall,s,3)
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [s@macro-hangupcall:3] ExecIf(“SIP/1036-00003d63”, “0?Set(CDR(recordingfile)=)”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [s@macro-hangupcall:3] ExecIf(“SIP/1036-00003d63”, “0?Set(CDR(recordingfile)=)”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/1036-00003d63”, “”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/1036-00003d63”, “”) in new stack
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/1036-00003d63’ in macro ‘hangupcall’
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/1036-00003d63’ in macro ‘hangupcall’
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on ‘SIP/1036-00003d63’
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on ‘SIP/1036-00003d63’
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on ‘SIP/1036-00003d63’ in macro ‘dialout-trunk’
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on ‘SIP/1036-00003d63’ in macro ‘dialout-trunk’
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: == Spawn extension (from-internal, 9, 5) exited non-zero on ‘SIP/1036-00003d63’
/var/log/asterisk/full-20130626:[2013-06-25 15:42:31] VERBOSE[23752] pbx.c: == Spawn extension (from-internal, 9, 5) exited non-zero on ‘SIP/1036-00003d63’
Any ideas what the problem might be? I’m trying to get a packet capture of one of the calls but it’s so random, and we have so many handsets, that it might be hard.
Olly