Systems hangs up after dialing an option in IVR

Basically the call gets drop when an option is redirected to a ring group or follow me with multiple extensions listed in them

Philippe here is the log.

Kerby

new stack
– Called 5146670927/5146670927
– Call accepted by 206.191.37.138 (format ulaw)
– Format for call is ulaw
– IAX2/5146670927-1 is making progress passing it to SIP/103-094625b0
– IAX2/5146670927-1 answered SIP/103-094625b0
– Hungup ‘IAX2/5146670927-1’
== Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on ‘SIP/103-094625b0’ in macro ‘dialout-trunk’
== Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on ‘SIP/103-094625b0’
– Executing Macro(“SIP/103-094625b0”, “hangupcall”) in new stack
– Executing ResetCDR(“SIP/103-094625b0”, “w”) in new stack
– Executing NoCDR(“SIP/103-094625b0”, “”) in new stack
– Executing GotoIf(“SIP/103-094625b0”, “1?skiprg”) in new stack
– Goto (macro-hangupcall,s,6)
– Executing GotoIf(“SIP/103-094625b0”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,9)
– Executing Wait(“SIP/103-094625b0”, “5”) in new stack
– Got SIP response 503 “Service Unavailable: cli is wrong, check your configuration, switch to 08 number” back from 204.147.183.18

it looks like your ringgroup has a recording as part of it and the call is dropped as soon as it gets ready to play the recording. What codec is the call coming in on? Any chance you are using g729 with no local license - so it can’t play the message and drops the call (you’ll see messages to the effect of “can’t translate” in the log. Try getting rid of the message that is part of the ringgroup and see what happens then.

Hi!

I tried what u said. The call went through. I will double check when i’ll be in the office tomorrow. But im pretty sure that u nailed it.

We recorded all of our announcements using *77. Everything was fine until we updated the freepbx packages last week.

Thanks

Kerby

please be sure to come back with a final wrap up so that others who run into similar issues can stumble accross this thread and benefit form the final conclusion…

Removing the announcement fix the problem. No more dropped calls

I’ve confirmed that ring groups with announcements don’t work. While turning off the announcement makes it start working again, I need to have announcements, is there any fix for this bug in process?

it does work (assuming we are talking the same thing):

extenernal call => IVR => Ring Group (with announce) => list_of_extensions

so you need to review the thread and your logs/cli to determine what else is causing the issue (did you check codecs as described previously)?

I’ve done some more debugging, incoming calls with ulaw codec work fine, incoming calls with gsm codec fall over:

/*
– Executing DeadAGI(“IAX2/vitel-inbound-7”, “recordingcheck|20070606-115101|1181145052.106”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
asterisk1CLI> recordingcheck|20070606-115101|1181145052.106: Recording enable for 232
asterisk1
CLI> recordingcheck|20070606-115101|1181145052.106: CALLFILENAME=g232-20070606-115101-1181145052.106
asterisk1CLI> – AGI Script recordingcheck completed, returning 0
– Executing MixMonitor(“IAX2/vitel-inbound-7”, “g232-20070606-115101-1181145052.106.wav”) in new stack
– Executing Set(“IAX2/vitel-inbound-7”, “RingGroupMethod=ringall”) in new stack
– Executing GotoIf(“IAX2/vitel-inbound-7”, “0?DIALGRP”) in new stack
– Executing Answer(“IAX2/vitel-inbound-7”, “”) in new stack
– Executing Wait(“IAX2/vitel-inbound-7”, “1”) in new stack
== Begin MixMonitor Recording IAX2/vitel-inbound-7
asterisk1
CLI> == Spawn extension (ext-group, 603, 20) exited non-zero on ‘IAX2/vitel-inbound-7’
== End MixMonitor Recording IAX2/vitel-inbound-7
asterisk1*CLI> – Hungup 'IAX2/vitel-inbound-7’
Tx-Frame Retry[000] – OSeqno: 004 ISeqno: 004 Type: IAX Subclass: HANGUP
Timestamp: 08819ms SCall: 00007 DCall: 00061 [64.2.142.31:4569]
CAUSE CODE : 0

*/

Is it supposed to transcode announcements? I can’t guarantee which codec will be in use on incoming calls, but there isn’t a license limit on gsm codecs, AFAICT…

yup - no license on gsm

the log file may have additional clues

what happens if you turn off call recording, maybe there is some issue with the interaction of call recording and the transcoding?

No difference on call recording.

What part of what log file do you want?

Thanks for the reply.

I tried you wrote already. The calls are still dropped. It does not drop calls when the numbers in the group are only external number like our cell phones.

How do i set the verbosity to 5

Thanks

Kerby

set verbose 5

or when you start the cli from linux, asterisk -rvvvvv

p

After recreating the ringgroup i still get the same problem. The call is dropped when i select the option that is redirect to that ringgroup

in new stack
– Playing ‘custom/After_Hours_Blg_Menu’ (language ‘en’)
== CDR updated on IAX2/5146670927-4
– Executing DBdel(“IAX2/5146670927-4”, “”) in new stack
– Executing Set(“IAX2/5146670927-4”, “__NODEST=”) in new stack
– Executing Goto(“IAX2/5146670927-4”, “ext-group|600|1”) in new stack
– Goto (ext-group,600,1)
– Executing Macro(“IAX2/5146670927-4”, “user-callerid|”) in new stack
– Executing NoOp(“IAX2/5146670927-4”, “user-callerid: 4505083545”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “0?report”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “0?start”) in new stack
– Executing Set(“IAX2/5146670927-4”, “REALCALLERIDNUM=4505083545”) in new stack
– Executing NoOp(“IAX2/5146670927-4”, “REALCALLERIDNUM is 4505083545”) in new stack
– Executing Set(“IAX2/5146670927-4”, “AMPUSER=”) in new stack
– Executing Set(“IAX2/5146670927-4”, “AMPUSERCIDNAME=”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “1?report”) in new stack
– Goto (macro-user-callerid,s,11)
– Executing NoOp(“IAX2/5146670927-4”, "TTL: ARG1: ") in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “0?continue”) in new stack
– Executing Set(“IAX2/5146670927-4”, “_TTL=64”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,21)
– Executing NoOp(“IAX2/5146670927-4”, “Using CallerID “” <4505083545>”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “1?skipdb”) in new stack
– Goto (ext-group,600,4)
– Executing Set(“IAX2/5146670927-4”, “__NODEST=”) in new stack
– Executing Set(“IAX2/5146670927-4”, “__BLKVM_OVERRIDE=BLKVM/600/IAX2/5146670927-4”) in new stack
– Executing Set(“IAX2/5146670927-4”, “__BLKVM_BASE=600”) in new stack
– Executing Set(“IAX2/5146670927-4”, “DB(BLKVM/600/IAX2/5146670927-4)=TRUE”) in new stack
– Executing Set(“IAX2/5146670927-4”, “RRNODEST=”) in new stack
– Executing Set(“IAX2/5146670927-4”, “__NODEST=600”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “1?REPCID”) in new stack
– Goto (ext-group,600,14)
– Executing NoOp(“IAX2/5146670927-4”, "CALLERID(name) is ") in new stack
– Executing Set(“IAX2/5146670927-4”, “RGPREFIX=Sup_Fr”) in new stack
– Executing Set(“IAX2/5146670927-4”, “CALLERID(name)=Sup_Fr”) in new stack
– Executing Set(“IAX2/5146670927-4”, “RecordMethod=Group”) in new stack
– Executing Macro(“IAX2/5146670927-4”, “record-enable|102-103-104|Group”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “0?2:4”) in new stack
– Goto (macro-record-enable,s,4)
– Executing DeadAGI(“IAX2/5146670927-4”, “recordingcheck|20070527-200802|1180310868.41”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
– AGI Script recordingcheck completed, returning 0
– Executing NoOp(“IAX2/5146670927-4”, “No recording needed”) in new stack
– Executing Set(“IAX2/5146670927-4”, “RingGroupMethod=ringall”) in new stack
– Executing GotoIf(“IAX2/5146670927-4”, “0?DIALGRP”) in new stack
– Executing Answer(“IAX2/5146670927-4”, “”) in new stack
– Executing Wait(“IAX2/5146670927-4”, “1”) in new stack
== Spawn extension (ext-group, 600, 22) exited non-zero on ‘IAX2/5146670927-4’
– Hungup ‘IAX2/5146670927-4’

– Executing BackGround(“IAX2/5146670927-3”, “custom/After_Hours_Blg_Menu”) in new stack
– Playing ‘custom/After_Hours_Blg_Menu’ (language ‘en’)
== CDR updated on IAX2/5146670927-3
– Executing DBdel(“IAX2/5146670927-3”, “”) in new stack
– Executing Set(“IAX2/5146670927-3”, “__NODEST=”) in new stack
– Executing Goto(“IAX2/5146670927-3”, “ext-group|600|1”) in new stack
– Goto (ext-group,600,1)
– Executing Macro(“IAX2/5146670927-3”, “user-callerid|”) in new stack
– Executing NoOp(“IAX2/5146670927-3”, “user-callerid: 4505083545”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “0?report”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “0?start”) in new stack
– Executing Set(“IAX2/5146670927-3”, “REALCALLERIDNUM=4505083545”) in new stack
– Executing NoOp(“IAX2/5146670927-3”, “REALCALLERIDNUM is 4505083545”) in new stack
– Executing Set(“IAX2/5146670927-3”, “AMPUSER=”) in new stack
– Executing Set(“IAX2/5146670927-3”, “AMPUSERCIDNAME=”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “1?report”) in new stack
– Goto (macro-user-callerid,s,11)
– Executing NoOp(“IAX2/5146670927-3”, "TTL: ARG1: ") in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “0?continue”) in new stack
– Executing Set(“IAX2/5146670927-3”, “_TTL=64”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,21)
– Executing NoOp(“IAX2/5146670927-3”, “Using CallerID “” <4505083545>”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “1?skipdb”) in new stack
– Goto (ext-group,600,4)
– Executing Set(“IAX2/5146670927-3”, “__NODEST=”) in new stack
– Executing Set(“IAX2/5146670927-3”, “__BLKVM_OVERRIDE=BLKVM/600/IAX2/5146670927-3”) in new stack
– Executing Set(“IAX2/5146670927-3”, “__BLKVM_BASE=600”) in new stack
– Executing Set(“IAX2/5146670927-3”, “DB(BLKVM/600/IAX2/5146670927-3)=TRUE”) in new stack
– Executing Set(“IAX2/5146670927-3”, “RRNODEST=”) in new stack
– Executing Set(“IAX2/5146670927-3”, “__NODEST=600”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “1?REPCID”) in new stack
– Goto (ext-group,600,14)
– Executing NoOp(“IAX2/5146670927-3”, "CALLERID(name) is ") in new stack
– Executing Set(“IAX2/5146670927-3”, “RGPREFIX=Sup_Fr”) in new stack
– Executing Set(“IAX2/5146670927-3”, “CALLERID(name)=Sup_Fr”) in new stack
– Executing Set(“IAX2/5146670927-3”, “RecordMethod=Group”) in new stack
– Executing Macro(“IAX2/5146670927-3”, “record-enable|102-103-104|Group”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “0?2:4”) in new stack
– Goto (macro-record-enable,s,4)
– Executing DeadAGI(“IAX2/5146670927-3”, “recordingcheck|20070527-201210|1180311124.42”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
AGI Tx >> agi_request: recordingcheck
AGI Tx >> agi_channel: IAX2/5146670927-3
AGI Tx >> agi_language: en
AGI Tx >> agi_type: IAX2
AGI Tx >> agi_uniqueid: 1180311124.42
AGI Tx >> agi_callerid: 4505083545
AGI Tx >> agi_calleridname: Sup_Fr
AGI Tx >> agi_callingpres: 0
AGI Tx >> agi_callingani2: 0
AGI Tx >> agi_callington: 0
AGI Tx >> agi_callingtns: 0
AGI Tx >> agi_dnid: unknown
AGI Tx >> agi_rdnis: unknown
AGI Tx >> agi_context: macro-record-enable
AGI Tx >> agi_extension: s
AGI Tx >> agi_priority: 4
AGI Tx >> agi_enhanced: 0.0
AGI Tx >> agi_accountcode:
AGI Tx >>
AGI Rx << GET VARIABLE ARG2
AGI Tx >> 200 result=1 (Group)
AGI Rx << GET VARIABLE ARG1
AGI Tx >> 200 result=1 (102-103-104)
AGI Rx << SET VARIABLE RecEnable "DISABLED"
AGI Tx >> 200 result=1
AGI Rx << DATABASE GET “AMPUSER” "102/recording"
AGI Tx >> 200 result=1 (out=Adhoc|in=Adhoc)
AGI Rx << DATABASE GET “AMPUSER” "103/recording"
AGI Tx >> 200 result=1 (out=Adhoc|in=Adhoc)
AGI Rx << DATABASE GET “AMPUSER” "104/recording"
AGI Tx >> 200 result=1 (out=Adhoc|in=Adhoc)
AGI Rx << Content-type: text/html
AGI Tx >> 510 Invalid or unknown command
AGI Rx << X-Powered-By: PHP/4.3.11
AGI Tx >> 510 Invalid or unknown command
AGI Rx << >
AGI Tx >> 510 Invalid or unknown command
– AGI Script recordingcheck completed, returning 0
– Executing NoOp(“IAX2/5146670927-3”, “No recording needed”) in new stack
– Executing Set(“IAX2/5146670927-3”, “RingGroupMethod=ringall”) in new stack
– Executing GotoIf(“IAX2/5146670927-3”, “0?DIALGRP”) in new stack
– Executing Answer(“IAX2/5146670927-3”, “”) in new stack
– Executing Wait(“IAX2/5146670927-3”, “1”) in new stack
== Spawn extension (ext-group, 600, 22) exited non-zero on ‘IAX2/5146670927-3’
– Hungup ‘IAX2/5146670927-3’

there is not enough here to see the full flow of what is going on - you probably need to provide more. All this tells me is that a call was initiated, accepted and then hungup (and I’m not quite sure off hand about the final 503 and message although a bit more context might bring some light).

Also - you should edit your message with a bit more context of how the call is coming in and what the expected results should be - so others reading the forum may provide their feedback to the issue also.

Sorry here is more details. Let me know if that is enough. Please ignore my previous post. I redid the test.

This is what i did

I called from 5143737860 press 0 in the IVR. Once I pressed 0 the call dropped
0 is supposed to redirect to ringgroup 600 which has ext 101,102,103,104 in it.

Other options that redirect to a core extension work. If we set an incoming rout to go to the ringgroup the call is dropped too. The problem is not neccessarily with the IVR

Thanks

Kerby

new stack
– Executing GotoIf(“IAX2/5146670927-1”, “1?skipdb”) in new stack
– Goto (ext-group,600,4)
– Executing Set(“IAX2/5146670927-1”, “__NODEST=”) in new stack
– Executing Set(“IAX2/5146670927-1”, “__BLKVM_OVERRIDE=BLKVM/600/IAX2/5146670927-1”) in new stack
– Executing Set(“IAX2/5146670927-1”, “__BLKVM_BASE=600”) in new stack
– Executing Set(“IAX2/5146670927-1”, “DB(BLKVM/600/IAX2/5146670927-1)=TRUE”) in new stack
– Executing Set(“IAX2/5146670927-1”, “RRNODEST=”) in new stack
– Executing Set(“IAX2/5146670927-1”, “__NODEST=600”) in new stack
– Executing GotoIf(“IAX2/5146670927-1”, “1?REPCID”) in new stack
– Goto (ext-group,600,14)
– Executing NoOp(“IAX2/5146670927-1”, "CALLERID(name) is ") in new stack
– Executing Set(“IAX2/5146670927-1”, “RGPREFIX=Sup_Fr”) in new stack
– Executing Set(“IAX2/5146670927-1”, “CALLERID(name)=Sup_Fr”) in new stack
– Executing Set(“IAX2/5146670927-1”, “RecordMethod=Group”) in new stack
– Executing Macro(“IAX2/5146670927-1”, “record-enable|102-101-103-104|Group”) in new stack
– Executing GotoIf(“IAX2/5146670927-1”, “0?2:4”) in new stack
– Goto (macro-record-enable,s,4)
– Executing DeadAGI(“IAX2/5146670927-1”, “recordingcheck|20070525-120136|1180108893.165”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
– AGI Script recordingcheck completed, returning 0
– Executing NoOp(“IAX2/5146670927-1”, “No recording needed”) in new stack
– Executing Set(“IAX2/5146670927-1”, “RingGroupMethod=ringall”) in new stack
– Executing GotoIf(“IAX2/5146670927-1”, “0?DIALGRP”) in new stack
– Executing Answer(“IAX2/5146670927-1”, “”) in new stack
– Executing Wait(“IAX2/5146670927-1”, “1”) in new stack
== Spawn extension (ext-group, 600, 22) exited non-zero on ‘IAX2/5146670927-1’
– Hungup ‘IAX2/5146670927-1’
– Got SIP response 503 “Service Unavailable: cli is wrong, check your configuration, switch to 08 number” back from 204.147.183.18

can you do the following. First, delete and recreate that ringgroup and then make sure you go back to any ivr/inbound routing/etc. that use that ringgroup and that they are still pointing to it. Then turn up your verbosity to 5 when you take the trace. If it still fails, put one trace like you did and make a second one where you type ‘agi debug’ at the cli which will expose much more of what might be happening inside the dialparties agi script that does the ringgroup.