Strange Hangup in mid-call

[JasonH]

Okay, this is a weird one. I have a person on a SIP phone connected to my PIAF server. When she makes an outgoing call, about 15 minutes in to the call, the call is hung up and she hears a busy signal.

I just grabbed the log of her call that disconnected, and it is as follows:

Dialing out:

[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/3010-00000c68", "0?sub-pincheck,s,1") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/3010-00000c68", "0?disabletrunk,1") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:4] Set("SIP/3010-00000c68", "DIAL_NUMBER=14105551111") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:5] Set("SIP/3010-00000c68", "DIAL_TRUNK_OPTIONS=tr") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:6] Set("SIP/3010-00000c68", "OUTBOUND_GROUP=OUT_1") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/3010-00000c68", "1?nomax") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/3010-00000c68", "0?skipoutcid") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:10] Set("SIP/3010-00000c68", "DIAL_TRUNK_OPTIONS=") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-outbound-callerid:6] Set("SIP/3010-00000c68", "USEROUTCID=") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-outbound-callerid:7] Set("SIP/3010-00000c68", "EMERGENCYCID=") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-outbound-callerid:8] Set("SIP/3010-00000c68", "TRUNKOUTCID="CompanyName" <6195551234>") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/3010-00000c68", "1?trunkcid") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-outbound-callerid:12] ExecIf("SIP/3010-00000c68", "1?Set(CALLERID(all)=CompanyName <6195551234>)") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-outbound-callerid:13] ExecIf("SIP/3010-00000c68", "0?Set(CALLERID(all)=)") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/3010-00000c68", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:12] ExecIf("SIP/3010-00000c68", "1?AGI(fixlocalprefix)") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] res_agi.c:     -- <SIP/3010-00000c68>AGI Script fixlocalprefix completed, returning 0
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:13] Set("SIP/3010-00000c68", "OUTNUM=14105551111") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:14] Set("SIP/3010-00000c68", "custom=DAHDI/g0") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/3010-00000c68", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^))") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:16] Macro("SIP/3010-00000c68", "dialout-trunk-predial-hook,") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/3010-00000c68", "") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:17] GotoIf("SIP/3010-00000c68", "0?bypass,1") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/3010-00000c68", "0?customtrunk") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] pbx.c:     -- Executing [s@macro-dialout-trunk:19] Dial("SIP/3010-00000c68", "DAHDI/g0/14105551111,300,") in new stack
[2010-03-22 16:30:07] VERBOSE[24458] app_dial.c:     -- DAHDI/1-1 is proceeding passing it to SIP/3010-00000c68
[2010-03-22 16:30:13] VERBOSE[24458] app_dial.c:     -- DAHDI/1-1 answered SIP/3010-00000c68

16 minutes in to the call this happens:

[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*773010' priority 1 to ext-dnd-hints (0xb7d63350)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*773010' priority -1 to ext-dnd-hints (0xb7d63350)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*823010' priority 1 to ext-findmefollow (0xb77ce808)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*823010' priority -1 to ext-findmefollow (0xb77ce808)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5100' priority 1 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5100' priority 2 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5100' priority -1 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5101' priority 1 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5101' priority 2 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5101' priority -1 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5102' priority 1 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5102' priority 2 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*453010*5102' priority -1 to ext-queues (0xb77c8958)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 1 to from-queue-exten-only (0xb71508a8)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 2 to from-queue-exten-only (0xb71508a8)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 3 to from-queue-exten-only (0xb71508a8)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 4 to from-queue-exten-only (0xb71508a8)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 1 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 2 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority -1 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*3010' priority 1 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*3010' priority 2 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension 'vmb3010' priority 1 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension 'vmb3010' priority 2 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension 'vmu3010' priority 1 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension 'vmu3010' priority 2 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension 'vms3010' priority 1 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension 'vms3010' priority 2 to ext-local (0x8b6cec0)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 1 to from-did-direct-ivr (0xb6abd548)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 2 to from-did-direct-ivr (0xb6abd548)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '3010' priority 3 to from-did-direct-ivr (0xb6abd548)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*3010' priority 1 to from-did-direct-ivr (0xb6abd548)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*3010' priority 2 to from-did-direct-ivr (0xb6abd548)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*3010' priority 3 to from-did-direct-ivr (0xb6abd548)
[2010-03-22 16:46:02] VERBOSE[24589] pbx.c:     -- Added extension '*3010' priority 4 to from-did-direct-ivr (0xb6abd548)

And then right after that, she gets a hangup:

[2010-03-22 16:46:47] VERBOSE[24458] pbx.c:     -- Executing [h@macro-dialout-trunk:1] Macro("SIP/3010-00000c68", "hangupcall,") in new stack
[2010-03-22 16:46:47] VERBOSE[24458] pbx.c:     -- Executing [s@macro-hangupcall:1] GotoIf("SIP/3010-00000c68", "1?skiprg") in new stack
[2010-03-22 16:46:47] VERBOSE[24458] pbx.c:     -- Executing [s@macro-hangupcall:4] GotoIf("SIP/3010-00000c68", "1?skipblkvm") in new stack
[2010-03-22 16:46:47] VERBOSE[24458] pbx.c:     -- Executing [s@macro-hangupcall:7] GotoIf("SIP/3010-00000c68", "1?theend") in new stack
[2010-03-22 16:46:47] VERBOSE[24458] pbx.c:     -- Executing [s@macro-hangupcall:9] Hangup("SIP/3010-00000c68", "") in new stack
[2010-03-22 16:46:47] VERBOSE[24458] app_macro.c:   == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'SIP/3010-00000c68' in macro 'hangupcall'
[2010-03-22 16:46:47] VERBOSE[24458] features.c:   == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/3010-00000c68'
[2010-03-22 16:46:47] VERBOSE[24458] app_macro.c:   == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on 'SIP/3010-00000c68' in macro 'dialout-trunk'
[2010-03-22 16:46:47] VERBOSE[24458] pbx.c:   == Spawn extension (from-internal, 14105551111, 4) exited non-zero on 'SIP/3010-00000c68'

I have no idea what is causing this or where to even start. Any suggestions would be GREATLY appreciated!!

 

[JasonH]

Found a possible solution. In sip_general_custom.conf file, add the line "session-timers=refuse". This will disable any call timers from interrupting the calls.

Someone may need to know this if they're running 1.6.1.10. Apparently it has been fixed in 1.6.2.