Hello Everyone i am sorry but need help been struggling to get my new site up for weeks was silently lurking the forum to look for a solution but i am frustrated nothing is working.So site is connected to main PBX with trunk and Outbound routes i have 6 other site running similar setups all working except this new site.
So inter company calls work as well as receiving calls only problem is the users can’t make calls keep saying all circuits are busy.
Find attached my log file hope it helps
[2021-11-18 10:32:37] VERBOSE[43168] netsock2.c: Using SIP RTP Audio TOS bits 184
[2021-11-18 10:32:37] VERBOSE[43168] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2021-11-18 10:32:37] VERBOSE[43168] netsock2.c: Using SIP RTP Audio CoS mark 5
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:1] Macro("PJSIP/880-0000004c", "user-callerid,LIMIT,EXTERNAL,") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/880-0000004c", "TOUCH_MONITOR=1637231557.99") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/880-0000004c", "CHANCONTEXT=") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/880-0000004c", "CHANCONTEXT=") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/880-0000004c", "CHANEXTENCONTEXT=880-0000004c") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/880-0000004c", "CHANEXTEN=880-0000004c") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:6] Set("PJSIP/880-0000004c", "CALLERID(number)=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/880-0000004c", "AMPUSER=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:8] Set("PJSIP/880-0000004c", "HOTDESCKCHAN=880-0000004c") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:9] Set("PJSIP/880-0000004c", "HOTDESKEXTEN=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/880-0000004c", "HOTDESKCALL=0") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:11] ExecIf("PJSIP/880-0000004c", "0?Set(HOTDESKCALL=1)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:12] ExecIf("PJSIP/880-0000004c", "0?Set(CALLERID(name)=)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/880-0000004c", "0?report") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/880-0000004c", "1?Set(REALCALLERIDNUM=880)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/880-0000004c", "AMPUSER=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:16] GotoIf("PJSIP/880-0000004c", "0?limit") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/880-0000004c", "AMPUSERCIDNAME=Test") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:18] ExecIf("PJSIP/880-0000004c", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:19] GotoIf("PJSIP/880-0000004c", "0?report") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/880-0000004c", "AMPUSERCID=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:21] Set("PJSIP/880-0000004c", "__DIAL_OPTIONS=Ttr") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:22] Set("PJSIP/880-0000004c", "CALLERID(all)="Test" <880>") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/880-0000004c", "0?Set(CUSDIAL=)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/880-0000004c", "0?Set(CALLERID(all)="Test" <880>)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:25] GotoIf("PJSIP/880-0000004c", "0?limit") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:26] ExecIf("PJSIP/880-0000004c", "1?Set(GROUP(concurrency_limit)=880)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/880-0000004c", "0?Set(CHANNEL(language)=)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:28] NoOp("PJSIP/880-0000004c", "Macro Depth is 1") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:29] GotoIf("PJSIP/880-0000004c", "1?report2:macroerror") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (macro-user-callerid,s,30)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/880-0000004c", "1?continue") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (macro-user-callerid,s,49)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:49] Set("PJSIP/880-0000004c", "CALLERID(number)=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/880-0000004c", "CALLERID(name)=Test") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:51] GotoIf("PJSIP/880-0000004c", "0?cnum") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:52] Set("PJSIP/880-0000004c", "CDR(cnam)=Test") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/880-0000004c", "CDR(cnum)=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/880-0000004c", "CHANNEL(language)=en") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:2] Gosub("PJSIP/880-0000004c", "sub-record-check,s,1(out,0768177212,dontcare)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/880-0000004c", "0?initialized") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/880-0000004c", "__REC_STATUS=INITIALIZED") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/880-0000004c", "NOW=1637231557") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/880-0000004c", "__DAY=18") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/880-0000004c", "__MONTH=11") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/880-0000004c", "__YEAR=2021") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/880-0000004c", "__TIMESTR=20211118-103237") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/880-0000004c", "__FROMEXTEN=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/880-0000004c", "__MON_FMT=wav") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/880-0000004c", "Recordings initialized") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/880-0000004c", "0?Set(ARG3=dontcare)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/880-0000004c", "REC_POLICY_MODE_SAVE=") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/880-0000004c", "0?Set(REC_STATUS=NO)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/880-0000004c", "3?checkaction") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (sub-record-check,s,17)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/880-0000004c", "1?sub-record-check,out,1") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (sub-record-check,out,1)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [out@sub-record-check:1] NoOp("PJSIP/880-0000004c", "Outbound Recording Check from 880 to 0768177212") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [out@sub-record-check:2] Set("PJSIP/880-0000004c", "RECMODE=dontcare") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [out@sub-record-check:3] ExecIf("PJSIP/880-0000004c", "1?Goto(routewins)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (sub-record-check,out,7)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [out@sub-record-check:7] Gosub("PJSIP/880-0000004c", "recordcheck,1(dontcare,out,0768177212)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/880-0000004c", "Starting recording check against dontcare") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/880-0000004c", "dontcare") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/880-0000004c", "") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [out@sub-record-check:8] Return("PJSIP/880-0000004c", "") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:3] ExecIf("PJSIP/880-0000004c", "0 ?Set(CDR(accountcode)=)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:4] Set("PJSIP/880-0000004c", "_ROUTEID=1") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:5] Set("PJSIP/880-0000004c", "_ROUTENAME=ToHQ") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:6] Set("PJSIP/880-0000004c", "INTRACOMPANYROUTE=YES") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:7] Set("PJSIP/880-0000004c", "MOHCLASS=default") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:8] ExecIf("PJSIP/880-0000004c", "1?Set(TRUNKCIDOVERRIDE=Rustenburg)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:9] Set("PJSIP/880-0000004c", "_CALLERIDNAMEINTERNAL=Test") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:10] Set("PJSIP/880-0000004c", "_CALLERIDNUMINTERNAL=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:11] Set("PJSIP/880-0000004c", "_EMAILNOTIFICATION=FALSE") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:12] Set("PJSIP/880-0000004c", "_NODEST=") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [0768177212@from-internal:13] Macro("PJSIP/880-0000004c", "dialout-trunk,1,0768177212,,off") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:1] Set("PJSIP/880-0000004c", "DIAL_TRUNK=1") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("PJSIP/880-0000004c", "0?Set(DIAL_OPTIONS=tr)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("PJSIP/880-0000004c", "0?sub-pincheck,s,1()") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf("PJSIP/880-0000004c", "0?Set(CALLERID(num)=880)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf("PJSIP/880-0000004c", "0?disabletrunk,1") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:6] Set("PJSIP/880-0000004c", "DIAL_NUMBER=0768177212") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:7] Set("PJSIP/880-0000004c", "DIAL_TRUNK_OPTIONS=Ttr") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:8] Set("PJSIP/880-0000004c", "OUTBOUND_GROUP=OUT_1") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:9] Set("PJSIP/880-0000004c", "DIAL_TRUNK_OPTIONS=Tt") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf("PJSIP/880-0000004c", "1?nomax") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (macro-dialout-trunk,s,12)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("PJSIP/880-0000004c", "1?skipoutcid") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (macro-dialout-trunk,s,14)
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf("PJSIP/880-0000004c", "0?sub-flp-1,s,1()") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:15] Set("PJSIP/880-0000004c", "OUTNUM=0768177212") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:16] Set("PJSIP/880-0000004c", "custom=IAX2/Office") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("PJSIP/880-0000004c", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)Tt)") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("PJSIP/880-0000004c", "0?Set(DIAL_TRUNK_OPTIONS=TtM(confirm))") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:19] Macro("PJSIP/880-0000004c", "dialout-trunk-predial-hook,") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/880-0000004c", "") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf("PJSIP/880-0000004c", "0?skipcrm") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:21] Set("PJSIP/880-0000004c", "__CRM_DIRECTION=OUTBOUND") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:22] Set("PJSIP/880-0000004c", "__CRM_DESTINATION=0768177212") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:23] Set("PJSIP/880-0000004c", "__CRM_SOURCE=880") in new stack
[2021-11-18 10:32:37] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:24] AGI("PJSIP/880-0000004c", "agi://127.0.0.1/sangomacrm.agi") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] res_agi.c: <PJSIP/880-0000004c>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:25] Set("PJSIP/880-0000004c", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp("PJSIP/880-0000004c", "CRM Finished") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf("PJSIP/880-0000004c", "0?bypass,1") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf("PJSIP/880-0000004c", "1?Set(CONNECTEDLINE(num,i)=0768177212)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("PJSIP/880-0000004c", "1?Set(CONNECTEDLINE(name,i)=CID:880)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf("PJSIP/880-0000004c", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)880)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf("PJSIP/880-0000004c", "0?customtrunk") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf("PJSIP/880-0000004c", "0?Set(DIAL_TRUNK_OPTIONS=t)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:33] Set("PJSIP/880-0000004c", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-dialout-trunk:34] Dial("PJSIP/880-0000004c", "IAX2/Office/0768177212,300,Ttb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^0768177212^0768177212^1^1637231557^Test^880)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] app_stack.c: IAX2/Office-5864 Internal Gosub(func-apply-sipheaders,s,1(1)) start
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("IAX2/Office-5864", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("IAX2/Office-5864", "Applying SIP Headers to channel IAX2/Office-5864") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:3] Set("IAX2/Office-5864", "TECH=IAX2") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:4] Set("IAX2/Office-5864", "SIPHEADERKEYS=Alert-Info") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:5] While("IAX2/Office-5864", "1") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:6] Set("IAX2/Office-5864", "sipheader=unset") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf("IAX2/Office-5864", "0?SIPRemoveHeader(Alert-Info:)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf("IAX2/Office-5864", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("IAX2/Office-5864", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("IAX2/Office-5864", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("IAX2/Office-5864", "0?SIPAddHeader(Alert-Info:unset)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf("IAX2/Office-5864", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile("IAX2/Office-5864", "") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:5] While("IAX2/Office-5864", "0") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] pbx.c: Executing [s@func-apply-sipheaders:14] Return("IAX2/Office-5864", "") in new stack
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] app_stack.c: Spawn extension (, 0768177212, 1) exited non-zero on 'IAX2/Office-5864'
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] app_stack.c: IAX2/Office-5864 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] app_dial.c: Called IAX2/Office/0768177212
[2021-11-18 10:32:38] VERBOSE[2202][C-00000026] chan_iax2.c: Call accepted by 192.168.0.5:4569 (format ulaw)
[2021-11-18 10:32:38] VERBOSE[2202][C-00000026] chan_iax2.c: Format for call is (ulaw)
[2021-11-18 10:32:38] VERBOSE[14924][C-00000026] app_dial.c: IAX2/Office-5864 is making progress passing it to PJSIP/880-0000004c
[2021-11-18 10:32:40] NOTICE[14219] res_pjsip/pjsip_distributor.c: Request 'REGISTER' from '<sip:[email protected]>' failed for '192.200.7.1:5060' (callid: [email protected]) - Failed to authenticate
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] res_rtp_asterisk.c: Sent RTP packet to 192.168.0.58:5034 (type 00, seq 004868, ts 019371, len 000160)
[2021-11-18 10:32:40] NOTICE[43168] res_pjsip/pjsip_distributor.c: Request 'REGISTER' from '<sip:[email protected]>' failed for '192.200.7.1:5060' (callid: [email protected]) - Failed to authenticate
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] chan_iax2.c: Hungup 'IAX2/Office-5864'
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] app_macro.c: Spawn extension (macro-dialout-trunk, s, 34) exited non-zero on 'PJSIP/880-0000004c' in macro 'dialout-trunk'
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Spawn extension (from-internal, 0768177212, 13) exited non-zero on 'PJSIP/880-0000004c'
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [h@from-internal:1] Macro("PJSIP/880-0000004c", "hangupcall") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/880-0000004c", "1?theend") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (macro-hangupcall,s,3)
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/880-0000004c", "0?Set(CDR(recordingfile)=)") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/880-0000004c", "IAX2/Office-5864 montior file= ") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("PJSIP/880-0000004c", "1?skipagi") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx_builtins.c: Goto (macro-hangupcall,s,7)
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@macro-hangupcall:7] Hangup("PJSIP/880-0000004c", "") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/880-0000004c' in macro 'hangupcall'
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/880-0000004c'
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] app_stack.c: PJSIP/880-0000004c Internal Gosub(crm-hangup,s,1) start
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/880-0000004c", "Sending Hangup to CRM") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/880-0000004c", "HANGUP CAUSE: 127") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/880-0000004c", "0?Set(__CRM_VOICEMAIL=)") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/880-0000004c", "MASTER CHANNEL: 1637231557.99 = 1637231557.99") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/880-0000004c", "0?return") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/880-0000004c", "__CRM_HANGUP=1") in new stack
[2021-11-18 10:32:40] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/880-0000004c", "agi://127.0.0.1/sangomacrm.agi") in new stack
[2021-11-18 10:32:41] NOTICE[43168] res_pjsip/pjsip_distributor.c: Request 'REGISTER' from '<sip:[email protected]>' failed for '192.200.7.1:5060' (callid: [email protected]) - Failed to authenticate
[2021-11-18 10:32:41] VERBOSE[14924][C-00000026] res_agi.c: <PJSIP/880-0000004c>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0
[2021-11-18 10:32:41] VERBOSE[14924][C-00000026] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/880-0000004c", "") in new stack
[2021-11-18 10:32:41] VERBOSE[14924][C-00000026] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/880-0000004c'
[2021-11-18 10:32:41] VERBOSE[14924][C-00000026] app_stack.c: PJSIP/880-0000004c Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
[2021-11-18 10:32:47] NOTICE[43168] res_pjsip/pjsip_distributor.c: Request 'REGISTER' from '<sip:[email protected]>' failed for '192.200.126.100:5062' (callid: [email protected]) - Failed to authenticate
[2021-11-18 10:32:47] NOTICE[6704] res_pjsip/pjsip_distributor.c: Request 'REGISTER' from '<sip:[email protected]>' failed for '192.200.126.100:5062' (callid: [email protected]) - Failed to authenticate