Call Drops When Answered in Ring Group

General Help
1

I have a ring group setup to ring 3 extensions simultaneously (ringall) when a call comes in from outside. Whenever one of the extensions answers, the call immediately terminates. I’d like to be able to answer at one of the extensions and it stop ringing at the other extensions without the call completely terminating. I can call all 3 extensions from each other fine and if I set the inbound route to one of the extensions instead of the ring group, everything is fine. Below is part of my log and the FreePBX and Asterisk versions. Any ideas what’s wrong?

Thanks,
Bill

FreePBX version 13.0.143
Asterisk Version: 13.9.1

[2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] res_agi.c: dialparties.agi: Filtered ARG3: 4002-4003-4007 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] res_agi.c: <SIP/198.199.84.66-000000d5>AGI Script dialparties.agi completed, returning 0 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:9] NoOp("SIP/198.199.84.66-000000d5", "Returned from dialparties with groups to dial") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:10] Set("SIP/198.199.84.66-000000d5", "LOOPCNT=3") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:11] Set("SIP/198.199.84.66-000000d5", "ITER=1") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:12] Set("SIP/198.199.84.66-000000d5", "EXTTOCALL=4002") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:13] NoOp("SIP/198.199.84.66-000000d5", "Working with 4002") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:14] Set("SIP/198.199.84.66-000000d5", "ITER=2") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:15] GotoIf("SIP/198.199.84.66-000000d5", "1?ndloopbegin") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx_builtins.c: Goto (macro-dial,s,12) [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:12] Set("SIP/198.199.84.66-000000d5", "EXTTOCALL=4003") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:13] NoOp("SIP/198.199.84.66-000000d5", "Working with 4003") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:14] Set("SIP/198.199.84.66-000000d5", "ITER=3") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:15] GotoIf("SIP/198.199.84.66-000000d5", "1?ndloopbegin") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx_builtins.c: Goto (macro-dial,s,12) [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:12] Set("SIP/198.199.84.66-000000d5", "EXTTOCALL=4007") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:13] NoOp("SIP/198.199.84.66-000000d5", "Working with 4007") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:14] Set("SIP/198.199.84.66-000000d5", "ITER=4") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:15] GotoIf("SIP/198.199.84.66-000000d5", "0?ndloopbegin") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:16] Macro("SIP/198.199.84.66-000000d5", "dial-ringall-predial-hook,") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/198.199.84.66-000000d5", "") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-dial:17] Dial("SIP/198.199.84.66-000000d5", "SIP/4002&SIP/4003&SIP/4007,50,trM(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] netsock2.c: Using SIP RTP TOS bits 184 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] netsock2.c: Using SIP RTP CoS mark 5 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] netsock2.c: Using SIP RTP TOS bits 184 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] netsock2.c: Using SIP RTP CoS mark 5 [2016-07-01 14:40:32] WARNING[10310][C-0000006e] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Subscriber absent) [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_stack.c: SIP/4002-000000d6 Internal Gosub(func-apply-sipheaders,s,1) start [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/4002-000000d6", "Applying SIP Headers to channel") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/4002-000000d6", "SIPHEADERKEYS=") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/4002-000000d6", "0") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_while.c: Jumping to priority 7 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:8] Return("SIP/4002-000000d6", "") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_stack.c: Spawn extension (from-internal, 4000, 1) exited non-zero on 'SIP/4002-000000d6' [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_stack.c: SIP/4002-000000d6 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL= [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_stack.c: SIP/4003-000000d7 Internal Gosub(func-apply-sipheaders,s,1) start [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp("SIP/4003-000000d7", "Applying SIP Headers to channel") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:2] Set("SIP/4003-000000d7", "SIPHEADERKEYS=") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:3] While("SIP/4003-000000d7", "0") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_while.c: Jumping to priority 7 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@func-apply-sipheaders:8] Return("SIP/4003-000000d7", "") in new stack [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_stack.c: Spawn extension (from-internal, 4000, 1) exited non-zero on 'SIP/4003-000000d7' [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_stack.c: SIP/4003-000000d7 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL= [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_dial.c: Called SIP/4002 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_dial.c: Called SIP/4003 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_dial.c: SIP/4003-000000d7 connected line has changed. Saving it until answer for SIP/198.199.84.66-000000d5 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_dial.c: SIP/4002-000000d6 connected line has changed. Saving it until answer for SIP/198.199.84.66-000000d5 [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_dial.c: SIP/4002-000000d6 is ringing [2016-07-01 14:40:32] VERBOSE[10310][C-0000006e] app_dial.c: SIP/4003-000000d7 is ringing [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] app_dial.c: SIP/4002-000000d6 connected line has changed. Saving it until answer for SIP/198.199.84.66-000000d5 [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] app_dial.c: SIP/4002-000000d6 answered SIP/198.199.84.66-000000d5 [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:1] Set("SIP/4002-000000d6", "__MACRO_RESULT=") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:2] Set("SIP/4002-000000d6", "CFIGNORE=") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:3] Set("SIP/4002-000000d6", "MASTER_CHANNEL(CFIGNORE)=") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:4] Set("SIP/4002-000000d6", "FORWARD_CONTEXT=from-internal") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:5] Set("SIP/4002-000000d6", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("SIP/4002-000000d6", "blkvm-clr,") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-blkvm-clr:1] Set("SIP/4002-000000d6", "SHARED(BLKVM,SIP/198.199.84.66-000000d5)=") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-blkvm-clr:2] Set("SIP/4002-000000d6", "GOSUB_RETVAL=") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("SIP/4002-000000d6", "") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("SIP/4002-000000d6", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=4002)") in new stack [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("SIP/4002-000000d6", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Basement)") in new stack [2016-07-01 14:40:38] VERBOSE[10321][C-0000006e] bridge_channel.c: Channel SIP/4002-000000d6 joined 'simple_bridge' basic-bridge <4627f2dd-837c-4276-a953-ad3eea05f84a> [2016-07-01 14:40:38] VERBOSE[10310][C-0000006e] bridge_channel.c: Channel SIP/198.199.84.66-000000d5 joined 'simple_bridge' basic-bridge <4627f2dd-837c-4276-a953-ad3eea05f84a> [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] bridge_channel.c: Channel SIP/198.199.84.66-000000d5 left 'simple_bridge' basic-bridge <4627f2dd-837c-4276-a953-ad3eea05f84a> [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] app_macro.c: Spawn extension (macro-dial, s, 17) exited non-zero on 'SIP/198.199.84.66-000000d5' in macro 'dial' [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] pbx.c: Spawn extension (ext-group, 4000, 14) exited non-zero on 'SIP/198.199.84.66-000000d5' [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] pbx.c: Executing [h@ext-group:1] Macro("SIP/198.199.84.66-000000d5", "hangupcall,") in new stack [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/198.199.84.66-000000d5", "1?theend") in new stack [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] pbx_builtins.c: Goto (macro-hangupcall,s,3) [2016-07-01 14:40:39] VERBOSE[10321][C-0000006e] bridge_channel.c: Channel SIP/4002-000000d6 left 'simple_bridge' basic-bridge <4627f2dd-837c-4276-a953-ad3eea05f84a> [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/198.199.84.66-000000d5", "0?Set(CDR(recordingfile)=)") in new stack [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] pbx.c: Executing [s@macro-hangupcall:4] Hangup("SIP/198.199.84.66-000000d5", "") in new stack [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'SIP/198.199.84.66-000000d5' in macro 'hangupcall' [2016-07-01 14:40:39] VERBOSE[10310][C-0000006e] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/198.199.84.66-000000d5'

2

There’s something wrong there, but there’s no errors saying WHY the call immediately aborted. At a guess, there’s a codec issue somewhere. Make sure you lock all your devices and trunks to G711 or G722, don’t let them use any others.

3

Try changing Send Progress to No

4

I saw this with a DAHDI installation I did about 6 months ago - it was an incompatible CODEC issue.

Just something else to look for,

5

If nothing works out, use a queue as a ring group, always works and has the same features as a ring group (plus many more).

6

I set the codecs on all the extensions and trunk to G711 ulaw, but that didn’t seem to work. However, when I set the “Send Progress” to No, it worked! Hallelujah! Thanks everyone for all your help!