Disconnects instead of listening to tones

I’ve run into a serious problem with our FreePBX installation. When using Confirm Calls, IVR, or conference calls (with pin) the system disconnects the user INSTEAD of listening for touch tones.

Conference call debug:
– Executing [3888@from-internal:1] Macro(“SIP/3805-b7c14980”, “user-callerid|”) in new stack
– Executing [s@macro-user-callerid:1] NoOp(“SIP/3805-b7c14980”, “user-callerid: device 3805”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/3805-b7c14980”, “AMPUSER=3805”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/3805-b7c14980”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/3805-b7c14980”, “1|Set|REALCALLERIDNUM=3805”) in new stack
– Executing [s@macro-user-callerid:5] NoOp(“SIP/3805-b7c14980”, “REALCALLERIDNUM is 3805”) in new stack
– Executing [s@macro-user-callerid:6] Set(“SIP/3805-b7c14980”, “AMPUSER=3805”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/3805-b7c14980”, “AMPUSERCIDNAME=Billy Kidney”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/3805-b7c14980”, “0?report”) in new stack
– Executing [s@macro-user-callerid:9] Set(“SIP/3805-b7c14980”, “AMPUSERCID=8664022800”) in new stack
– Executing [s@macro-user-callerid:10] Set(“SIP/3805-b7c14980”, “CALLERID(all)=“Billy Kidney” <8664022800>”) in new stack
– Executing [s@macro-user-callerid:11] Set(“SIP/3805-b7c14980”, “REALCALLERIDNUM=3805”) in new stack
– Executing [s@macro-user-callerid:12] ExecIf(“SIP/3805-b7c14980”, “0|Set|CHANNEL(language)=”) in new stack
– Executing [s@macro-user-callerid:13] NoOp(“SIP/3805-b7c14980”, "TTL: ARG1: ") in new stack
– Executing [s@macro-user-callerid:14] GotoIf(“SIP/3805-b7c14980”, “0?continue”) in new stack
– Executing [s@macro-user-callerid:15] Set(“SIP/3805-b7c14980”, “__TTL=64”) in new stack
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/3805-b7c14980”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,23)
– Executing [s@macro-user-callerid:23] NoOp(“SIP/3805-b7c14980”, “Using CallerID “Billy Kidney” <8664022800>”) in new stack
– Executing [3888@from-internal:2] Set(“SIP/3805-b7c14980”, “MEETME_ROOMNUM=3888”) in new stack
– Executing [3888@from-internal:3] GotoIf(“SIP/3805-b7c14980”, “0?READPIN”) in new stack
– Executing [3888@from-internal:4] Answer(“SIP/3805-b7c14980”, “”) in new stack
– Executing [3888@from-internal:5] Wait(“SIP/3805-b7c14980”, “1”) in new stack
– Executing [3888@from-internal:6] Set(“SIP/3805-b7c14980”, “PINCOUNT=0”) in new stack
– Executing [3888@from-internal:7] Read(“SIP/3805-b7c14980”, “PIN|enter-conf-pin-number||||”) in new stack
– User disconnected
== Spawn extension (from-internal, 3888, 7) exited non-zero on ‘SIP/3805-b7c14980’
– Executing [h@from-internal:1] Macro(“SIP/3805-b7c14980”, “hangupcall”) in new stack
– Executing [s@macro-hangupcall:1] ResetCDR(“SIP/3805-b7c14980”, “w”) in new stack
– Executing [s@macro-hangupcall:2] NoCDR(“SIP/3805-b7c14980”, “”) in new stack
– Executing [s@macro-hangupcall:3] GotoIf(“SIP/3805-b7c14980”, “1?skiprg”) in new stack
– Goto (macro-hangupcall,s,6)
– Executing [s@macro-hangupcall:6] GotoIf(“SIP/3805-b7c14980”, “1?skipblkvm”) in new stack
– Goto (macro-hangupcall,s,9)
– Executing [s@macro-hangupcall:9] GotoIf(“SIP/3805-b7c14980”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,11)
– Executing [s@macro-hangupcall:11] Hangup(“SIP/3805-b7c14980”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/3805-b7c14980’ in macro ‘hangupcall’
== Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/3805-b7c14980’

Confirm Call debug:
– Zap/4-1 answered Local/9760XXXX@from-internal-01b6,2
– Local/9760XXXX@from-internal-01b6,1 answered Local/RG-3805-97607917#@from-internal-992b,2
– Executing [s@macro-confirm:1] Set(“Local/9760XXXX@from-internal-01b6,1”, “LOOPCOUNT=0”) in new stack
– Executing [s@macro-confirm:2] NoOp(“Local/9760XXXX@from-internal-01b6,1”, "CALLCONFIRMCID: ") in new stack
– Executing [s@macro-confirm:3] Set(“Local/9760XXXX@from-internal-01b6,1”, “__MACRO_RESULT=ABORT”) in new stack
– Executing [s@macro-confirm:4] Set(“Local/9760XXXX@from-internal-01b6,1”, “MSG1=incoming-call-1-accept-2-decline”) in new stack
– Executing [s@macro-confirm:5] Read(“Local/9760XXXX@from-internal-01b6,1”, “INPUT|incoming-call-1-accept-2-decline|1||1|5”) in new stack
– Accepting a maximum of 1 digits.
– User disconnected

IVR debug:
– Executing [411@from-internal:1] Answer(“SIP/3805-b7c1dc00”, “”) in new stack
– Executing [411@from-internal:2] Wait(“SIP/3805-b7c1dc00”, “1”) in new stack
– Executing [411@from-internal:3] Goto(“SIP/3805-b7c1dc00”, “pbdirectory|1”) in new stack
– Goto (from-internal,pbdirectory,1)
– Executing [pbdirectory@from-internal:1] Macro(“SIP/3805-b7c1dc00”, “user-callerid|”) in new stack
– Executing [s@macro-user-callerid:1] NoOp(“SIP/3805-b7c1dc00”, “user-callerid: device 3805”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/3805-b7c1dc00”, “AMPUSER=3805”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/3805-b7c1dc00”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/3805-b7c1dc00”, “1|Set|REALCALLERIDNUM=3805”) in new stack
– Executing [s@macro-user-callerid:5] NoOp(“SIP/3805-b7c1dc00”, “REALCALLERIDNUM is 3805”) in new stack
– Executing [s@macro-user-callerid:6] Set(“SIP/3805-b7c1dc00”, “AMPUSER=3805”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/3805-b7c1dc00”, “AMPUSERCIDNAME=Billy Kidney”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/3805-b7c1dc00”, “0?report”) in new stack
– Executing [s@macro-user-callerid:9] Set(“SIP/3805-b7c1dc00”, “AMPUSERCID=8664022800”) in new stack
– Executing [s@macro-user-callerid:10] Set(“SIP/3805-b7c1dc00”, “CALLERID(all)=“Billy Kidney” <8664022800>”) in new stack
– Executing [s@macro-user-callerid:11] Set(“SIP/3805-b7c1dc00”, “REALCALLERIDNUM=3805”) in new stack
– Executing [s@macro-user-callerid:12] ExecIf(“SIP/3805-b7c1dc00”, “0|Set|CHANNEL(language)=”) in new stack
– Executing [s@macro-user-callerid:13] NoOp(“SIP/3805-b7c1dc00”, "TTL: ARG1: ") in new stack
– Executing [s@macro-user-callerid:14] GotoIf(“SIP/3805-b7c1dc00”, “0?continue”) in new stack
– Executing [s@macro-user-callerid:15] Set(“SIP/3805-b7c1dc00”, “__TTL=64”) in new stack
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/3805-b7c1dc00”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,23)
– Executing [s@macro-user-callerid:23] NoOp(“SIP/3805-b7c1dc00”, “Using CallerID “Billy Kidney” <8664022800>”) in new stack
– Executing [pbdirectory@from-internal:2] AGI(“SIP/3805-b7c1dc00”, “pbdirectory”) in new stack
– Launched AGI Script /usr/share/asterisk/agi-bin/pbdirectory
== Parsing ‘/etc/asterisk/manager.conf’: Found
== Parsing ‘/etc/asterisk/manager_additional.conf’: Found
== Parsing ‘/etc/asterisk/manager_custom.conf’: Found
== Manager ‘admin’ logged on from 127.0.0.1
== Manager ‘admin’ logged off from 127.0.0.1
pbdirectory: test
pbdirectory: start loop
pbdirectory: loop = 0
– Playing ‘dir-nomatch’ (escape_digits=) (sample_offset 0)
== Parsing ‘/etc/asterisk/manager.conf’: Found
== Parsing ‘/etc/asterisk/manager_additional.conf’: Found
== Parsing ‘/etc/asterisk/manager_custom.conf’: Found

Whenever the system should wait for the user, it doesn’t, it either disconnects the user or goes into a loop UNLESS you call your voicemail, which works almost flawlessly.

Ideas?

I am having the same issue any help on this would be great.

We’ve found something even more interesting, if sent to the IVR, the system doesn’t play the recorded sound BUT if transferred to the phonebook system it works properly.

Ideas?

I found this error was due to the extra sounds not being installed. Checking out the /var/log/asterisk/full will tell you the exact error. you can get the extra sounds on digium’s site.