New FreePBX install "All circuits are busy now" message

Hey all,

I’ve set up a new FreePBX install and am finding that whenever I dial an outbound number I get the “All circuits are busy now” message.

I set up a DID number to check that my connection is good and have no issues there with inbound working a treat.

When I try to make a call I get the following in the log file:

[2018-12-07 20:13:02] VERBOSE[3370] pbx_variables.c: Setting global variable ‘SIPDOMAIN’ to ‘192.168.2.99’
[2018-12-07 20:13:02] VERBOSE[3370] netsock2.c: Using SIP RTP Audio TOS bits 184
[2018-12-07 20:13:02] VERBOSE[3370] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2018-12-07 20:13:02] VERBOSE[3370] netsock2.c: Using SIP RTP Audio CoS mark 5
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] Macro(“PJSIP/1000-0000000b”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] Set(“PJSIP/1000-0000000b”, “TOUCH_MONITOR=1544173982.11”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] Set(“PJSIP/1000-0000000b”, “AMPUSER=1000”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] GotoIf(“PJSIP/1000-0000000b”, “0?report”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/1000-0000000b”, “1?Set(REALCALLERIDNUM=1000)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] Set(“PJSIP/1000-0000000b”, “AMPUSER=1000”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:6] GotoIf(“PJSIP/1000-0000000b”, “0?limit”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:7] Set(“PJSIP/1000-0000000b”, “AMPUSERCIDNAME=1000”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:8] ExecIf(“PJSIP/1000-0000000b”, "0?Set(_CIDMASQUERADING=TRUE)") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:9] GotoIf(“PJSIP/1000-0000000b”, “0?report”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:10] Set(“PJSIP/1000-0000000b”, “AMPUSERCID=1000”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:11] Set(“PJSIP/1000-0000000b”, "_DIAL_OPTIONS=HhTtr") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:12] Set(“PJSIP/1000-0000000b”, “CALLERID(all)=“1000” <1000>”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:13] GotoIf(“PJSIP/1000-0000000b”, “0?limit”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:14] ExecIf(“PJSIP/1000-0000000b”, “1?Set(GROUP(concurrency_limit)=1000)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:15] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CHANNEL(language)=)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:16] NoOp(“PJSIP/1000-0000000b”, “Macro Depth is 1”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:17] GotoIf(“PJSIP/1000-0000000b”, “1?report2:macroerror”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:18] GotoIf(“PJSIP/1000-0000000b”, “1?continue”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-user-callerid,s,37)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:37] Set(“PJSIP/1000-0000000b”, “CALLERID(number)=1000”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:38] Set(“PJSIP/1000-0000000b”, “CALLERID(name)=1000”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:39] GotoIf(“PJSIP/1000-0000000b”, “0?cnum”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:40] Set(“PJSIP/1000-0000000b”, “CDR(cnam)=1000”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:41] Set(“PJSIP/1000-0000000b”, “CDR(cnum)=1000”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:42] Set(“PJSIP/1000-0000000b”, “CHANNEL(language)=en”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] Gosub(“PJSIP/1000-0000000b”, “sub-record-check,s,1(out,011614594444,dontcare)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/1000-0000000b”, “0?initialized”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] Set(“PJSIP/1000-0000000b”, "_REC_STATUS=INITIALIZED") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] Set(“PJSIP/1000-0000000b”, “NOW=1544173982”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] Set(“PJSIP/1000-0000000b”, "_DAY=07") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] Set(“PJSIP/1000-0000000b”, "_MONTH=12") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:6] Set(“PJSIP/1000-0000000b”, "_YEAR=2018") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:7] Set(“PJSIP/1000-0000000b”, "_TIMESTR=20181207-201302") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:8] Set(“PJSIP/1000-0000000b”, "_FROMEXTEN=1000") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:9] Set(“PJSIP/1000-0000000b”, "_MON_FMT=wav") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:10] NoOp(“PJSIP/1000-0000000b”, “Recordings initialized”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/1000-0000000b”, “0?Set(ARG3=dontcare)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:12] Set(“PJSIP/1000-0000000b”, “REC_POLICY_MODE_SAVE=”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:13] ExecIf(“PJSIP/1000-0000000b”, “0?Set(REC_STATUS=NO)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:14] GotoIf(“PJSIP/1000-0000000b”, “3?checkaction”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (sub-record-check,s,17)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:17] GotoIf(“PJSIP/1000-0000000b”, “1?sub-record-check,out,1”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (sub-record-check,out,1)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/1000-0000000b”, “Outbound Recording Check from 1000 to 011614594444”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] Set(“PJSIP/1000-0000000b”, “RECMODE=yes”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/1000-0000000b”, “0?Goto(routewins)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/1000-0000000b”, “0?Goto(routewins)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] Gosub(“PJSIP/1000-0000000b”, “recordcheck,1(yes,out,011614594444)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/1000-0000000b”, “Starting recording check against yes”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] Goto(“PJSIP/1000-0000000b”, “yes”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (sub-record-check,recordcheck,9)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:9] ExecIf(“PJSIP/1000-0000000b”, “0?Return()”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:10] Set(“PJSIP/1000-0000000b”, "_REC_POLICY_MODE=YES") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:11] Goto(“PJSIP/1000-0000000b”, “startrec”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (sub-record-check,recordcheck,16)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:16] NoOp(“PJSIP/1000-0000000b”, “Starting recording: out, 011614594444”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:17] Set(“PJSIP/1000-0000000b”, “AUDIOHOOK_INHERIT(MixMonitor)=yes”) in new stack
[2018-12-07 20:13:02] ERROR[22389][C-00000007] pbx_functions.c: Function AUDIOHOOK_INHERIT not registered
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:18] Set(“PJSIP/1000-0000000b”, "_CALLFILENAME=out-011614594444-1000-20181207-201302-1544173982.11") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:19] MixMonitor(“PJSIP/1000-0000000b”, “2018/12/07/out-011614594444-1000-20181207-201302-1544173982.11.wav,abi(LOCAL_MIXMON_ID),”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:20] Set(“PJSIP/1000-0000000b”, "_MIXMON_ID=0x7ff4b0029ab0") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:21] Set(“PJSIP/1000-0000000b”, "_RECORD_ID=PJSIP/1000-0000000b") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:22] Set(“PJSIP/1000-0000000b”, "_REC_STATUS=RECORDING") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:23] Set(“PJSIP/1000-0000000b”, “CDR(recordingfile)=out-011614594444-1000-20181207-201302-1544173982.11.wav”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:24] Return(“PJSIP/1000-0000000b”, “”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]ub-record-check:6] Return(“PJSIP/1000-0000000b”, “”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/1000-0000000b”, “0 ?Set(CDR(accountcode)=)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] Set(“PJSIP/1000-0000000b”, “MOHCLASS=default”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] ExecIf(“PJSIP/1000-0000000b”, “1?Set(TRUNKCIDOVERRIDE=<131010>)”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:6] Set(“PJSIP/1000-0000000b”, "NODEST=") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:7] Macro(“PJSIP/1000-0000000b”, “dialout-trunk,1,011614594444,off”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] Set(“PJSIP/1000-0000000b”, “DIAL_TRUNK=1”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] ExecIf(“PJSIP/1000-0000000b”, “0?Set(DIAL_OPTIONS=Hhtr)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] GosubIf(“PJSIP/1000-0000000b”, “0?sub-pincheck,s,1()”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CALLERID(num)=1000)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] GotoIf(“PJSIP/1000-0000000b”, “0?disabletrunk,1”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:6] Set(“PJSIP/1000-0000000b”, “DIAL_NUMBER=011614594444”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:7] Set(“PJSIP/1000-0000000b”, “DIAL_TRUNK_OPTIONS=HhTtr”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:8] Set(“PJSIP/1000-0000000b”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:9] Set(“PJSIP/1000-0000000b”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:10] GotoIf(“PJSIP/1000-0000000b”, “0?nomax”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:11] GotoIf(“PJSIP/1000-0000000b”, “0?chanfull”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:12] GotoIf(“PJSIP/1000-0000000b”, “0?skipoutcid”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:13] Macro(“PJSIP/1000-0000000b”, “outbound-callerid,1”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/1000-0000000b”, “1000”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] NoOp(“PJSIP/1000-0000000b”, “”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] NoOp(“PJSIP/1000-0000000b”, “off”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CALLERPRES(name-pres)=)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]erid:5] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CALLERPRES(num-pres)=)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:6] ExecIf(“PJSIP/1000-0000000b”, “0?Set(REALCALLERIDNUM=1000)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:7] ExecIf(“PJSIP/1000-0000000b”, “0?Set(AMPUSER=1000)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:8] GotoIf(“PJSIP/1000-0000000b”, “1?normcid”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-outbound-callerid,s,12)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:12] Set(“PJSIP/1000-0000000b”, “USEROUTCID=”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:13] Set(“PJSIP/1000-0000000b”, “EMERGENCYCID=”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:14] Set(“PJSIP/1000-0000000b”, “TRUNKOUTCID=131010”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:15] GotoIf(“PJSIP/1000-0000000b”, “1?trunkcid”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:20] ExecIf(“PJSIP/1000-0000000b”, “1?Set(CALLERID(all)=131010)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:21] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CALLERID(all)=)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:22] ExecIf(“PJSIP/1000-0000000b”, “1?Set(CALLERID(all)=<131010>)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:23] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CALLERPRES(name-pres)=prohib_passed_screen)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:24] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CALLERPRES(num-pres)=prohib_passed_screen)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:25] Set(“PJSIP/1000-0000000b”, “CDR(outbound_cnum)=131010”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:26] Set(“PJSIP/1000-0000000b”, “CDR(outbound_cnam)=”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:14] GosubIf(“PJSIP/1000-0000000b”, “0?sub-flp-1,s,1()”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:15] Set(“PJSIP/1000-0000000b”, “OUTNUM=011614594444”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:16] Set(“PJSIP/1000-0000000b”, “custom=PJSIP”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:17] ExecIf(“PJSIP/1000-0000000b”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:18] ExecIf(“PJSIP/1000-0000000b”, “0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:19] Macro(“PJSIP/1000-0000000b”, “dialout-trunk-predial-hook,”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] MacroExit(“PJSIP/1000-0000000b”, “”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:20] GotoIf(“PJSIP/1000-0000000b”, “0?skipcrm”) in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:21] Set(“PJSIP/1000-0000000b”, "_CRM_DIRECTION=OUTBOUND") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:22] Set(“PJSIP/1000-0000000b”, "_CRM_DESTINATION=011614594444") in new stack
_[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:23] Set(“PJSIP/1000-0000000b”, "_CRM_SOURCE=1000") in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:24] AGI(“PJSIP/1000-0000000b”, “sangomacrm.agi”) in new stack
[2018-12-07 20:13:02] VERBOSE[22389][C-00000007] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2018-12-07 20:13:02] VERBOSE[22396][C-00000007] app_mixmonitor.c: Begin MixMonitor Recording PJSIP/1000-0000000b
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] res_agi.c: <PJSIP/1000-0000000b>AGI Script sangomacrm.agi completed, returning 0
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:25] Set(“PJSIP/1000-0000000b”, “CHANNEL(hangup_handler_push)=crm-hangup,s,1”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:26] NoOp(“PJSIP/1000-0000000b”, “CRM Finished”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:27] GotoIf(“PJSIP/1000-0000000b”, “0?bypass,1”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:28] ExecIf(“PJSIP/1000-0000000b”, “1?Set(CONNECTEDLINE(num,i)=011614594444)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:29] ExecIf(“PJSIP/1000-0000000b”, “1?Set(CONNECTEDLINE(name,i)=CID:131010)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:30] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)131010)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:31] GotoIf(“PJSIP/1000-0000000b”, “0?customtrunk”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:32] Dial(“PJSIP/1000-0000000b”, “PJSIP/[email protected]_Route,300,Tb(func-apply-sipheaders^s^1)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] app_stack.c: PJSIP/Flow_Route-0000000c Internal Gosub(func-apply-sipheaders,s,1) start
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] ExecIf(“PJSIP/Flow_Route-0000000c”, “0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] NoOp(“PJSIP/Flow_Route-0000000c”, “Applying SIP Headers to channel”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] Set(“PJSIP/Flow_Route-0000000c”, “SIPHEADERKEYS=”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] ExecIf(“PJSIP/Flow_Route-0000000c”, “0?Set(Rheader=1)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] While(“PJSIP/Flow_Route-0000000c”, “0”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] app_while.c: Jumping to priority 9
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:10] ExecIf(“PJSIP/Flow_Route-0000000c”, “0?SIPRemoveHeader(Alert-Info:)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:11] ExecIf(“PJSIP/Flow_Route-0000000c”, “0?Set(PJSIP_HEADER(remove,Alert-Info)=)”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:12] Return(“PJSIP/Flow_Route-0000000c”, “”) in new stack
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] app_stack.c: Spawn extension (from-pstn, 011614594444, 1) exited non-zero on ‘PJSIP/Flow_Route-0000000c’
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] app_stack.c: PJSIP/Flow_Route-0000000c Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
[2018-12-07 20:13:05] VERBOSE[22389][C-00000007] app_dial.c: Called PJSIP/[email protected]_Route
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:33] NoOp(“PJSIP/1000-0000000b”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:34] GotoIf(“PJSIP/1000-0000000b”, “0?continue,1:s-CHANUNAVAIL,1”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] Set(“PJSIP/1000-0000000b”, “RC=21”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] Goto(“PJSIP/1000-0000000b”, “21,1”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-dialout-trunk,21,1)
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] Goto(“PJSIP/1000-0000000b”, “continue,1”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/1000-0000000b”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] ExecIf(“PJSIP/1000-0000000b”, “1?Set(CALLERID(number)=1000)”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:8] Macro(“PJSIP/1000-0000000b”, “outisbusy,”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] Progress(“PJSIP/1000-0000000b”, “”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] GotoIf(“PJSIP/1000-0000000b”, “0?emergency,1”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] GotoIf(“PJSIP/1000-0000000b”, “0?intracompany,1”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] Playback(“PJSIP/1000-0000000b”, “all-circuits-busy-now&please-try-call-later, noanswer”) in new stack
[2018-12-07 20:13:06] VERBOSE[22389][C-00000007] file.c: <PJSIP/1000-0000000b> Playing ‘all-circuits-busy-now.g722’ (language ‘en’)
[2018-12-07 20:13:08] VERBOSE[22389][C-00000007] file.c: <PJSIP/1000-0000000b> Playing ‘please-try-call-later.ulaw’ (language ‘en’)
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] Macro(“PJSIP/1000-0000000b”, “hangupcall”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] GotoIf(“PJSIP/1000-0000000b”, “1?theend”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/1000-0000000b”, “0?Set(CDR(recordingfile)=)”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] NoOp(“PJSIP/1000-0000000b”, " monior file= /var/spool/asterisk/monitor/2018/12/07/out-011614594444-1000-20181207-201302-1544173982.11.wav") in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] AGI(“PJSIP/1000-0000000b”, “attendedtransfer-rec-restart.php,/var/spool/asterisk/monitor/2018/12/07/out-011614594444-1000-20181207-201302-1544173982.11.wav”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] res_agi.c: <PJSIP/1000-0000000b>AGI Script attendedtransfer-rec-restart.php completed, returning 0
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:6] Hangup(“PJSIP/1000-0000000b”, “”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on ‘PJSIP/1000-0000000b’ in macro ‘hangupcall’
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘PJSIP/1000-0000000b’
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] app_stack.c: PJSIP/1000-0000000b Internal Gosub(crm-hangup,s,1) start
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:1] NoOp(“PJSIP/1000-0000000b”, “Sending Hangup to CRM”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:2] NoOp(“PJSIP/1000-0000000b”, “HANGUP CAUSE: 21”) in new stack
_[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:3] ExecIf(“PJSIP/1000-0000000b”, "0?Set(_CRM_VOICEMAIL=)") in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:4] NoOp(“PJSIP/1000-0000000b”, “MASTER CHANNEL: 1544173982.11 = 1544173982.11”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:5] GotoIf(“PJSIP/1000-0000000b”, “0?return”) in new stack
_[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:6] Set(“PJSIP/1000-0000000b”, "_CRM_HANGUP=1") in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:7] AGI(“PJSIP/1000-0000000b”, “sangomacrm.agi”) in new stack
[2018-12-07 20:13:09] VERBOSE[22389][C-00000007] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
[2018-12-07 20:13:11] VERBOSE[22389][C-00000007] res_agi.c: <PJSIP/1000-0000000b>AGI Script sangomacrm.agi completed, returning 0
[2018-12-07 20:13:11] VERBOSE[22389][C-00000007] pbx.c: Executing [[email protected]:8] Return(“PJSIP/1000-0000000b”, “”) in new stack
[2018-12-07 20:13:11] VERBOSE[22389][C-00000007] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on ‘PJSIP/1000-0000000b’
[2018-12-07 20:13:11] VERBOSE[22389][C-00000007] app_stack.c: PJSIP/1000-0000000b Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
[2018-12-07 20:13:11] VERBOSE[22396][C-00000007] app_mixmonitor.c: MixMonitor close filestream (mixed)
[2018-12-07 20:13:11] VERBOSE[22396][C-00000007] app_mixmonitor.c: End MixMonitor Recording PJSIP/1000-0000000b

The number I have dialed is a random Australian number, but is a valid format.

SIP provider is Flowroute. Using PJSip with the default port (5060). Authentication is Outbound and registration is send.

Dial patters are:
011.
1NXXNXXXXXX
NXXNXXXXXX
NXXXXXX

I’m still fairly new to this so any help would be amazing.

Flowroute rejected the call because the number was improperly formatted.

Flowroute expects all numbers to start with the country code. If you want to set up your system for ‘US style’ dialing, then in your Outbound Route, put 011 in the prefix field and e.g. XX. in the match pattern.

Your 1NXXNXXXXXX pattern is ok, try dialing 18004377950 (free on Flowroute) which should announce your calling number.

If you want to allow 10-digit dialing in US, put 1 in the prepend and NXXNXXXXXX in the match pattern.

For 7-digit dialing, put e.g. 1212 in the prepend (if you are in area code 212) and NXXXXXX in the match pattern.

614594444 would not be a valid number in Australia – the code 4 indicates a mobile and there should be 8 digits following that.

It appears that you are trying to send 131010 as your outbound caller ID, which is not valid. A US number should be 11 digits, starting with 1.

Thanks for your reply Stewart.

I dialed 18004377950 and the call was able to connect without any issues so it looks like it’s my ‘Dial Pattern’.

I’m based in Australia and need to set up to dial Australian numbers which are generally for example 02 9876 5432 (or +61 2 9876 5432 from outside Australia). Problem is I’m not entirely sure how to set these dial patterns considering the calls are originating from a server in the US.

The US server is not an issue; you just need to set up the correct dial patterns. They would be the same for e.g. Voxbeam (UK based) or any provider that expects all destination numbers to start with the country code.

Oversimplified, if you want to dial e.g. 02 9876 5432 for Sydney and 0011 33 1 9876 5432 for Paris, you could use:
prepend 61 prefix 0 match pattern ZXX. and
prepend (blank) prefix 0011 match pattern XX.

However, it will be more complex because of special number formats, etc.

For better advice, please tell us a little about your application. Are you with GIO? Will you have other trunking providers on your system?

Why did you choose Flowroute? Although they are IMO a first class provider, you may have latency issues when calling Australia (though they don’t proxy the audio, they do use US and EU based carriers). Also, they wouldn’t support dialing 000 (though you could map that to a geographic number for police, etc.) You may have trouble reaching short codes. You may have trouble displaying a short code such as 131010 as your outbound caller ID (Flowroute won’t block it but their upstream carrier might).

Call is hitting Flowroute. They are denying it. You have your trunk settings right?

The number dialed is invalid (one too few digits).

1 Like

Oh it’s invalid for sure, hence my question. Not only is it a digit short for being a NANP destination but Flowroute doesn’t accept calls with 011 prefix they want the country code+number. So even if that last digit was there for the phone number, the prefix is invalid.

2 Likes

Thanks for all your help everyone. I’ve now been able to, with your help, get my dial plan sorted.

You’re all a bunch of legends.

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