SIP Trunk Inbound - The number you have dialed is no longer in service

FreePBX Providers
1

Currently running FreePBX 13.0.197 and having sporadic problems with a SIP inbound connection.

Here’s a overview of the workflow and where I see the problem.

This is being used for a newspaper subscription (circulation) queue. But it goes through a jump before it gets to the queue.

First the call comes into the VOIP system but then it sends the call out a SIP trunk to a computer automated phone system (http://isd.ca/index.htm) to allow the customers to take care of things via the phone.

The problem happens when the customer chooses at the automated system to talk to one of the customer service reps. The call most of the time but not always will get a message “the number you have dialed is no longer in service” The way it should work is the automated phone system transfers the call to an extension that has a number of time conditions to route the call to the correct CSR call center.

I’ve turned on verbose logging to see if anything stands out but I can’t see anything.

I’m sure more info is needed, just let me know.

Thanks in advance for any help.

2

Post a screenshot of the call log detail.

3

Here’s the screen shot of the call that had the message “This number is not in service”.

32%20AM
32%20AM1655×424 86.1 KB

4

Here’s the log of that call.

2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [1827@from-internal:1] Macro(“PJSIP/1100-000032f2”, “user-callerid,LIMIT,EXTERNAL,”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/1100-000032f2”, “TOUCH_MONITOR=1573599180.77213”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/1100-000032f2”, “AMPUSER=1100”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/1100-000032f2”, “0?report”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/1100-000032f2”, “1?Set(REALCALLERIDNUM=1100)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/1100-000032f2”, “AMPUSER=1100”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/1100-000032f2”, “0?limit”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/1100-000032f2”, “AMPUSERCIDNAME=Sean McCauley Deskphone”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:8] ExecIf(“PJSIP/1100-000032f2”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:9] GotoIf(“PJSIP/1100-000032f2”, “0?report”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/1100-000032f2”, “AMPUSERCID=1100”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:11] Set(“PJSIP/1100-000032f2”, “__DIAL_OPTIONS=Ttr”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:12] Set(“PJSIP/1100-000032f2”, “CALLERID(all)=“Sean McCauley Deskphone” <1100>”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(“PJSIP/1100-000032f2”, “0?limit”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“PJSIP/1100-000032f2”, “1?Set(GROUP(concurrency_limit)=1100)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:15] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CHANNEL(language)=)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:16] NoOp(“PJSIP/1100-000032f2”, “Macro Depth is 1”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:17] GotoIf(“PJSIP/1100-000032f2”, “1?report2:macroerror”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (macro-user-callerid,s,18)

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/1100-000032f2”, “1?continue”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (macro-user-callerid,s,37)

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:37] Set(“PJSIP/1100-000032f2”, “CALLERID(number)=1100”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:38] Set(“PJSIP/1100-000032f2”, “CALLERID(name)=Sean McCauley Deskphone”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:39] GotoIf(“PJSIP/1100-000032f2”, “0?cnum”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:40] Set(“PJSIP/1100-000032f2”, “CDR(cnam)=Sean McCauley Deskphone”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:41] Set(“PJSIP/1100-000032f2”, “CDR(cnum)=1100”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-user-callerid:42] Set(“PJSIP/1100-000032f2”, “CHANNEL(language)=en”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [1827@from-internal:2] Gosub(“PJSIP/1100-000032f2”, “sub-record-check,s,1(out,1827,dontcare)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/1100-000032f2”, “0?initialized”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/1100-000032f2”, “__REC_STATUS=INITIALIZED”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/1100-000032f2”, “NOW=1573599180”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/1100-000032f2”, “__DAY=12”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/1100-000032f2”, “__MONTH=11”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/1100-000032f2”, “__YEAR=2019”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/1100-000032f2”, “__TIMESTR=20191112-145300”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/1100-000032f2”, “__FROMEXTEN=1100”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/1100-000032f2”, “__MON_FMT=wav”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/1100-000032f2”, “Recordings initialized”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/1100-000032f2”, “0?Set(ARG3=dontcare)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/1100-000032f2”, “REC_POLICY_MODE_SAVE=”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/1100-000032f2”, “0?Set(REC_STATUS=NO)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/1100-000032f2”, “3?checkaction”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (sub-record-check,s,17)

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/1100-000032f2”, “1?sub-record-check,out,1”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (sub-record-check,out,1)

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/1100-000032f2”, “Outbound Recording Check from 1100 to 1827”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/1100-000032f2”, “RECMODE=dontcare”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/1100-000032f2”, “1?Goto(routewins)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (sub-record-check,out,7)

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/1100-000032f2”, “recordcheck,1(dontcare,out,1827)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/1100-000032f2”, “Starting recording check against dontcare”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/1100-000032f2”, “dontcare”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/1100-000032f2”, “”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/1100-000032f2”, “”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [1827@from-internal:3] ExecIf(“PJSIP/1100-000032f2”, “0 ?Set(CDR(accountcode)=)”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [1827@from-internal:4] Set(“PJSIP/1100-000032f2”, “ROUTE_CIDSAVE=“Sean McCauley Deskphone” <1100>”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [1827@from-internal:5] Set(“PJSIP/1100-000032f2”, “MOHCLASS=default”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [1827@from-internal:6] Set(“PJSIP/1100-000032f2”, “_NODEST=”) in new stack

[2019-11-12 14:53:00] VERBOSE[300][C-00002d75] pbx.c: Executing [1827@from-internal:7] Macro(“PJSIP/1100-000032f2”, “dialout-trunk,6,5413855800,on”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/1100-000032f2”, “DIAL_TRUNK=6”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/1100-000032f2”, “0?Set(DIAL_OPTIONS=tr)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/1100-000032f2”, “0?sub-pincheck,s,1()”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:4] GotoIf(“PJSIP/1100-000032f2”, “0?disabletrunk,1”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:5] Set(“PJSIP/1100-000032f2”, “DIAL_NUMBER=5413855800”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/1100-000032f2”, “DIAL_TRUNK_OPTIONS=Ttr”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/1100-000032f2”, “OUTBOUND_GROUP=OUT_6”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/1100-000032f2”, “DIAL_TRUNK_OPTIONS=T”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:9] GotoIf(“PJSIP/1100-000032f2”, “1?nomax”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (macro-dialout-trunk,s,11)

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf(“PJSIP/1100-000032f2”, “0?skipoutcid”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:12] Macro(“PJSIP/1100-000032f2”, “outbound-callerid,6”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:1] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CALLERPRES(name-pres)=)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:2] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CALLERPRES(num-pres)=)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:3] ExecIf(“PJSIP/1100-000032f2”, “0?Set(REALCALLERIDNUM=1100)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/1100-000032f2”, “0?Set(AMPUSER=1100)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:5] GotoIf(“PJSIP/1100-000032f2”, “1?normcid”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (macro-outbound-callerid,s,9)

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:9] Set(“PJSIP/1100-000032f2”, “USEROUTCID=5416332100”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:10] Set(“PJSIP/1100-000032f2”, “EMERGENCYCID=”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:11] Set(“PJSIP/1100-000032f2”, “TRUNKOUTCID=”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:12] GotoIf(“PJSIP/1100-000032f2”, “1?trunkcid”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (macro-outbound-callerid,s,18)

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:18] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CALLERID(all)=)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:19] ExecIf(“PJSIP/1100-000032f2”, “1?Set(CALLERID(all)=5416332100)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:20] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CALLERID(all)=)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:21] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:23] Set(“PJSIP/1100-000032f2”, “CDR(outbound_cnum)=5416332100”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-outbound-callerid:24] Set(“PJSIP/1100-000032f2”, “CDR(outbound_cnam)=”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:13] GosubIf(“PJSIP/1100-000032f2”, “0?sub-flp-6,s,1()”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:14] Set(“PJSIP/1100-000032f2”, “OUTNUM=5413855800”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/1100-000032f2”, “custom=PJSIP”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:16] ExecIf(“PJSIP/1100-000032f2”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/1100-000032f2”, “0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:18] Macro(“PJSIP/1100-000032f2”, “dialout-trunk-predial-hook,”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/1100-000032f2”, “”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:19] GotoIf(“PJSIP/1100-000032f2”, “0?skipcrm”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:20] Set(“PJSIP/1100-000032f2”, “__CRM_DIRECTION=OUTBOUND”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:21] Set(“PJSIP/1100-000032f2”, “__CRM_DESTINATION=5413855800”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:22] Set(“PJSIP/1100-000032f2”, “__CRM_SOURCE=1100”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:23] AGI(“PJSIP/1100-000032f2”, “sangomacrm.agi”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] res_agi.c: <PJSIP/1100-000032f2>AGI Script sangomacrm.agi completed, returning 0

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:24] Set(“PJSIP/1100-000032f2”, “CHANNEL(hangup_handler_push)=crm-hangup,s,1”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:25] NoOp(“PJSIP/1100-000032f2”, “CRM Finished”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:26] GotoIf(“PJSIP/1100-000032f2”, “0?bypass,1”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:27] ExecIf(“PJSIP/1100-000032f2”, “1?Set(CONNECTEDLINE(num,i)=5413855800)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf(“PJSIP/1100-000032f2”, “1?Set(CONNECTEDLINE(name,i)=CID:5416332100)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)5416332100)”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:30] GotoIf(“PJSIP/1100-000032f2”, “0?customtrunk”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-dialout-trunk:31] Dial(“PJSIP/1100-000032f2”, “PJSIP/5413855800@Chatterbox_Santa_Anna_05-2018,300,T”) in new stack

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] app_dial.c: Called PJSIP/5413855800@Chatterbox_Santa_Anna_05-2018

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] app_dial.c: PJSIP/Chatterbox_Santa_Anna_05-2018-000032f3 is making progress passing it to PJSIP/1100-000032f2

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] app_dial.c: PJSIP/Chatterbox_Santa_Anna_05-2018-000032f3 is making progress passing it to PJSIP/1100-000032f2

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] app_dial.c: PJSIP/Chatterbox_Santa_Anna_05-2018-000032f3 answered PJSIP/1100-000032f2

[2019-11-12 14:53:01] VERBOSE[305][C-00002d75] bridge_channel.c: Channel PJSIP/Chatterbox_Santa_Anna_05-2018-000032f3 joined ‘simple_bridge’ basic-bridge <87e370f1-5f53-4a82-abc7-425eabb53dc8>

[2019-11-12 14:53:01] VERBOSE[300][C-00002d75] bridge_channel.c: Channel PJSIP/1100-000032f2 joined ‘simple_bridge’ basic-bridge <87e370f1-5f53-4a82-abc7-425eabb53dc8>

[2019-11-12 14:53:03] DTMF[300][C-00002d75] channel.c: DTMF begin ‘8’ received on PJSIP/1100-000032f2

[2019-11-12 14:53:03] DTMF[300][C-00002d75] channel.c: DTMF begin passthrough ‘8’ on PJSIP/1100-000032f2

[2019-11-12 14:53:03] DTMF[300][C-00002d75] channel.c: DTMF end ‘8’ received on PJSIP/1100-000032f2, duration 100 ms

[2019-11-12 14:53:03] DTMF[300][C-00002d75] channel.c: DTMF end accepted with begin ‘8’ on PJSIP/1100-000032f2

[2019-11-12 14:53:03] DTMF[300][C-00002d75] channel.c: DTMF end passthrough ‘8’ on PJSIP/1100-000032f2

[2019-11-12 14:53:17] VERBOSE[305][C-00002d75] bridge_channel.c: Channel PJSIP/Chatterbox_Santa_Anna_05-2018-000032f3 left ‘simple_bridge’ basic-bridge <87e370f1-5f53-4a82-abc7-425eabb53dc8>

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] bridge_channel.c: Channel PJSIP/1100-000032f2 left ‘simple_bridge’ basic-bridge <87e370f1-5f53-4a82-abc7-425eabb53dc8>

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] app_macro.c: Spawn extension (macro-dialout-trunk, s, 31) exited non-zero on ‘PJSIP/1100-000032f2’ in macro ‘dialout-trunk’

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Spawn extension (from-internal, 1827, 7) exited non-zero on ‘PJSIP/1100-000032f2’

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [h@from-internal:1] Macro(“PJSIP/1100-000032f2”, “hangupcall”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-hangupcall:1] GotoIf(“PJSIP/1100-000032f2”, “1?theend”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx_builtins.c: Goto (macro-hangupcall,s,3)

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-hangupcall:3] ExecIf(“PJSIP/1100-000032f2”, “0?Set(CDR(recordingfile)=)”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@macro-hangupcall:4] Hangup(“PJSIP/1100-000032f2”, “”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] app_macro.c: Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘PJSIP/1100-000032f2’ in macro ‘hangupcall’

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘PJSIP/1100-000032f2’

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] app_stack.c: PJSIP/1100-000032f2 Internal Gosub(crm-hangup,s,1) start

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:1] NoOp(“PJSIP/1100-000032f2”, “Sending Hangup to CRM”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:2] NoOp(“PJSIP/1100-000032f2”, “HANGUP CAUSE: 16”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:3] ExecIf(“PJSIP/1100-000032f2”, “0?Set(__CRM_VOICEMAIL=)”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:4] NoOp(“PJSIP/1100-000032f2”, “MASTER CHANNEL: 1573599180.77213 = 1573599180.77213”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:5] GotoIf(“PJSIP/1100-000032f2”, “0?return”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:6] Set(“PJSIP/1100-000032f2”, “__CRM_HANGUP=1”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:7] AGI(“PJSIP/1100-000032f2”, “sangomacrm.agi”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] res_agi.c: <PJSIP/1100-000032f2>AGI Script sangomacrm.agi completed, returning 0

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] pbx.c: Executing [s@crm-hangup:8] Return(“PJSIP/1100-000032f2”, “”) in new stack

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘PJSIP/1100-000032f2’

[2019-11-12 14:53:17] VERBOSE[300][C-00002d75] app_stack.c: PJSIP/1100-000032f2 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=

5

Figured out the automated phone system provider had a misconfiguration that was sending some of our calls to the wrong path.

6

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.