- 2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/100-00000288", "Macro Depth is 2") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/100-00000288", "1?report2:macroerror") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-user-callerid,s,31)
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/100-00000288", "0?continue") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:32] ExecIf("PJSIP/100-00000288", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:33] Set("PJSIP/100-00000288", "__TTL=64") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:34] GotoIf("PJSIP/100-00000288", "1?continue") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-user-callerid,s,50)
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/100-00000288", "CALLERID(number)=100") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/100-00000288", "CALLERID(name)=Reception R") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("PJSIP/100-00000288", "0?cnum") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/100-00000288", "CDR(cnam)=Reception R") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/100-00000288", "CDR(cnum)=100") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/100-00000288", "CHANNEL(language)=en_AU") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/100-00000288", "RingGroupMethod=none") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/100-00000288", "__EXTTOCALL=107") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/100-00000288", "__PICKUPMARK=107") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/100-00000288", "RT=") in new stack
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("PJSIP/100-00000288", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("PJSIP/100-00000288", "0?MacroExit()") in new stack
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:8] ExecIf("PJSIP/100-00000288", "0?Gosub(ext-intercom,*80107,1())") in new stack
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:9] ExecIf("PJSIP/100-00000288", "0?MacroExit()") in new stack
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:10] ExecIf("PJSIP/100-00000288", "0?ChanSpy(PJSIP/107,q)") in new stack
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:11] ExecIf("PJSIP/100-00000288", "0?MacroExit()") in new stack
- [2020-11-20 04:19:45] WARNING[3650][C-000002ab] chan_sip.c: This function can only be used on SIP channels.
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:12] ExecIf("PJSIP/100-00000288", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:13] ExecIf("PJSIP/100-00000288", "0?MacroExit()") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:14] ExecIf("PJSIP/100-00000288", "0?Gosub(ext-intercom,*80107,1())") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:15] ExecIf("PJSIP/100-00000288", "0?MacroExit()") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:16] ExecIf("PJSIP/100-00000288", "0?ChanSpy(PJSIP/107,q)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:17] ExecIf("PJSIP/100-00000288", "0?MacroExit()") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:18] Gosub("PJSIP/100-00000288", "sub-record-check,s,1(exten,107,dontcare)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/100-00000288", "0?initialized") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/100-00000288", "__REC_STATUS=INITIALIZED") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/100-00000288", "NOW=1605845985") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/100-00000288", "__DAY=20") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/100-00000288", "__MONTH=11") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/100-00000288", "__YEAR=2020") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/100-00000288", "__TIMESTR=20201120-041945") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/100-00000288", "__FROMEXTEN=100") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/100-00000288", "__MON_FMT=wav") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/100-00000288", "Recordings initialized") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/100-00000288", "0?Set(ARG3=dontcare)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/100-00000288", "REC_POLICY_MODE_SAVE=") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/100-00000288", "0?Set(REC_STATUS=NO)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/100-00000288", "5?checkaction") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (sub-record-check,s,17)
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/100-00000288", "1?sub-record-check,exten,1") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (sub-record-check,exten,1)
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/100-00000288", "Exten Recording Check between 100 and 107") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/100-00000288", "CALLTYPE=internal") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/100-00000288", "0?Set(CALLTYPE=)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/100-00000288", "CALLEE=dontcare") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/100-00000288", "0?Set(CALLEE=dontcare)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/100-00000288", "0?callee") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/100-00000288", "1?caller") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (sub-record-check,exten,13)
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/100-00000288", "RECMODE=dontcare") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:14] ExecIf("PJSIP/100-00000288", "0?Set(RECMODE=dontcare)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:15] ExecIf("PJSIP/100-00000288", "1?Set(RECMODE=dontcare)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:16] Gosub("PJSIP/100-00000288", "recordcheck,1(dontcare,internal,107)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/100-00000288", "Starting recording check against dontcare") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/100-00000288", "dontcare") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [exten@sub-record-check:17] Return("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:19] GotoIf("PJSIP/100-00000288", "1?macrodial") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-exten-vm,s,25)
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:25] GosubIf("PJSIP/100-00000288", "0?clrheader,1()") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-exten-vm:26] Macro("PJSIP/100-00000288", "dial-one,,HhTtr,107") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/100-00000288", "DEXTEN=107") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:2] Set("PJSIP/100-00000288", "__CRM_SOURCE=100") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:3] ExecIf("PJSIP/100-00000288", "0?Set(__EXTTOCALL=107)") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:4] Set("PJSIP/100-00000288", "DIALSTATUS_CW=") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:5] GosubIf("PJSIP/100-00000288", "0?screen,1()") in new stack
- [2020-11-20 04:19:45] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:6] GosubIf("PJSIP/100-00000288", "0?cf,1()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:7] GotoIf("PJSIP/100-00000288", "1?skip1") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-dial-one,s,10)
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/100-00000288", "0?nodial") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:11] GotoIf("PJSIP/100-00000288", "0?continue") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:12] Set("PJSIP/100-00000288", "EXTHASCW=ENABLED") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:13] GotoIf("PJSIP/100-00000288", "0?next1:cwinusebusy") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-dial-one,s,25)
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:25] GotoIf("PJSIP/100-00000288", "0?next3:continue") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-dial-one,s,27)
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:27] GotoIf("PJSIP/100-00000288", "0?nodial") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:28] GosubIf("PJSIP/100-00000288", "1?dstring,1():dlocal,1()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/100-00000288", "DSTRING=") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/100-00000288", "DEVICES=107") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/100-00000288", "0?Return()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/100-00000288", "0?Set(DEVICES=07)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/100-00000288", "LOOPCNT=1") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/100-00000288", "ITER=1") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/100-00000288", "THISDIAL=PJSIP/107") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("PJSIP/100-00000288", "1?zap2dahdi,1()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("PJSIP/100-00000288", "0?Return()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("PJSIP/100-00000288", "NEWDIAL=") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("PJSIP/100-00000288", "LOOPCNT2=1") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("PJSIP/100-00000288", "ITER2=1") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("PJSIP/100-00000288", "THISPART2=PJSIP/107") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("PJSIP/100-00000288", "0?Set(THISPART2=DAHDIIP/107)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("PJSIP/100-00000288", "NEWDIAL=PJSIP/107&") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("PJSIP/100-00000288", "ITER2=2") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("PJSIP/100-00000288", "0?begin2") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("PJSIP/100-00000288", "THISDIAL=PJSIP/107") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("PJSIP/100-00000288", "0?docheck") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:10] NoOp("PJSIP/100-00000288", "Debug: Found PJSIP Destination PJSIP/107") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:11] GotoIf("PJSIP/100-00000288", "0?doset") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:12] NoOp("PJSIP/100-00000288", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:13] Set("PJSIP/100-00000288", "THISDIAL=PJSIP/107/sip:107@192.168.0.55:5060") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:14] ExecIf("PJSIP/100-00000288", "0?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:15] GotoIf("PJSIP/100-00000288", "0?skipset") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/100-00000288", "DSTRING=PJSIP/107/sip:107@192.168.0.55:5060&") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:17] Set("PJSIP/100-00000288", "ITER=2") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:18] GotoIf("PJSIP/100-00000288", "0?begin") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:19] ExecIf("PJSIP/100-00000288", "0?Return()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:20] Set("PJSIP/100-00000288", "DSTRING=PJSIP/107/sip:107@192.168.0.55:5060") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [dstring@macro-dial-one:21] Return("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:29] GotoIf("PJSIP/100-00000288", "0?nodial") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/100-00000288", "0?skiptrace") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:31] GosubIf("PJSIP/100-00000288", "1?ctset,1():ctclear,1()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [ctset@macro-dial-one:1] Set("PJSIP/100-00000288", "DB(CALLTRACE/107)=100") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [ctset@macro-dial-one:2] Return("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:32] Set("PJSIP/100-00000288", "D_OPTIONS=HhTtr") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:33] GosubIf("PJSIP/100-00000288", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:34] NoOp("PJSIP/100-00000288", "Blind Transfer: , Attended Transfer: , User: 100, Alert Info: ") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:35] ExecIf("PJSIP/100-00000288", "1?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:36] ExecIf("PJSIP/100-00000288", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:37] ExecIf("PJSIP/100-00000288", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:38] ExecIf("PJSIP/100-00000288", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:39] ExecIf("PJSIP/100-00000288", "0?Set(ALERT_INFO=Normal;volume=)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:40] GosubIf("PJSIP/100-00000288", "0?func-set-sipheader,s,1(Alert-Info,)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:41] ExecIf("PJSIP/100-00000288", "0?Set(CHANNEL(musicclass)=)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:42] GosubIf("PJSIP/100-00000288", "0?qwait,1()") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:43] Set("PJSIP/100-00000288", "__CWIGNORE=") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:44] Set("PJSIP/100-00000288", "__KEEPCID=TRUE") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:45] GotoIf("PJSIP/100-00000288", "0?usegoto,1") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:46] GotoIf("PJSIP/100-00000288", "0?godial") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:47] Gosub("PJSIP/100-00000288", "sub-presencestate-display,s,1(107)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@sub-presencestate-display:1] Goto("PJSIP/100-00000288", "state-available,1") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (sub-presencestate-display,state-available,1)
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [state-available@sub-presencestate-display:1] Set("PJSIP/100-00000288", "PRESENCESTATE_DISPLAY=(Available)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [state-available@sub-presencestate-display:2] Return("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:48] Set("PJSIP/100-00000288", "CONNECTEDLINE(name,i)=Chris(Available)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:49] Set("PJSIP/100-00000288", "CONNECTEDLINE(num)=107") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:50] Set("PJSIP/100-00000288", "D_OPTIONS=HhTtr") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:51] Macro("PJSIP/100-00000288", "dialout-one-predial-hook,") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dialout-one-predial-hook:1] MacroExit("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:52] ExecIf("PJSIP/100-00000288", "0?Set(D_OPTIONS=HhtrI)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:53] NoOp("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:54] ExecIf("PJSIP/100-00000288", "0?Set(D_OPTIONS=HhTtrg)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-dial-one:55] Dial("PJSIP/100-00000288", "PJSIP/107/sip:107@192.168.0.55:5060,,HhTtrb(func-apply-sipheaders^s^1)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] app_stack.c: PJSIP/107-00000289 Internal Gosub(func-apply-sipheaders,s,1) start
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/107-00000289", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/107-00000289", "Applying SIP Headers to channel PJSIP/107-00000289") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/107-00000289", "TECH=PJSIP") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/107-00000289", "SIPHEADERKEYS=") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/107-00000289", "0") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] app_while.c: Jumping to priority 13
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/107-00000289", "") in new stack
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] app_stack.c: Spawn extension (from-internal, 107, 1) exited non-zero on 'PJSIP/107-00000289'
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] app_stack.c: PJSIP/107-00000289 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] app_dial.c: Called PJSIP/107/sip:107@192.168.0.55:5060
- [2020-11-20 04:19:46] VERBOSE[16223] netsock2.c: Using SIP RTP Audio TOS bits 184
- [2020-11-20 04:19:46] VERBOSE[16223] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
- [2020-11-20 04:19:46] VERBOSE[16223] netsock2.c: Using SIP RTP Audio CoS mark 5
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] app_dial.c: PJSIP/107-00000289 is ringing
- [2020-11-20 04:19:46] VERBOSE[3650][C-000002ab] app_dial.c: PJSIP/107-00000289 is ringing
- [2020-11-20 04:19:49] VERBOSE[3650][C-000002ab] app_dial.c: PJSIP/107-00000289 answered PJSIP/100-00000288
- [2020-11-20 04:19:49] VERBOSE[3753][C-000002ab] bridge_channel.c: Channel PJSIP/107-00000289 joined 'simple_bridge' basic-bridge <d3dd349f-c5d8-4412-9269-915eeb83a6a8>
- [2020-11-20 04:19:49] VERBOSE[3650][C-000002ab] bridge_channel.c: Channel PJSIP/100-00000288 joined 'simple_bridge' basic-bridge <d3dd349f-c5d8-4412-9269-915eeb83a6a8>
- [2020-11-20 04:20:02] VERBOSE[3753][C-000002ab] bridge_channel.c: Channel PJSIP/107-00000289 left 'simple_bridge' basic-bridge <d3dd349f-c5d8-4412-9269-915eeb83a6a8>
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] bridge_channel.c: Channel PJSIP/100-00000288 left 'simple_bridge' basic-bridge <d3dd349f-c5d8-4412-9269-915eeb83a6a8>
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] app_macro.c: Spawn extension (macro-dial-one, s, 55) exited non-zero on 'PJSIP/100-00000288' in macro 'dial-one'
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] app_macro.c: Spawn extension (macro-exten-vm, s, 26) exited non-zero on 'PJSIP/100-00000288' in macro 'exten-vm'
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Spawn extension (ext-local, 107, 3) exited non-zero on 'PJSIP/100-00000288'
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/100-00000288", "hangupcall,") in new stack
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/100-00000288", "1?theend") in new stack
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-hangupcall,s,3)
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/100-00000288", "0?Set(CDR(recordingfile)=)") in new stack
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/100-00000288", "PJSIP/107-00000289 montior file= ") in new stack
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("PJSIP/100-00000288", "1?skipagi") in new stack
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx_builtins.c: Goto (macro-hangupcall,s,7)
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Executing [s@macro-hangupcall:7] Hangup("PJSIP/100-00000288", "") in new stack
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/100-00000288' in macro 'hangupcall'
- [2020-11-20 04:20:02] VERBOSE[3650][C-000002ab] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/100-00000288'
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] bridge_channel.c: Channel SIP/siptrunk.vpbx.net.au-0000026c left 'simple_bridge' basic-bridge <4b2af75c-f650-4961-a09a-c5d02ad20c1f>
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] app_macro.c: Spawn extension (macro-dial, s, 23) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026c' in macro 'dial'
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Spawn extension (ext-group, 1000, 18) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026c'
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [h@ext-group:1] Macro("SIP/siptrunk.vpbx.net.au-0000026c", "hangupcall,") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026c", "1?theend") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx_builtins.c: Goto (macro-hangupcall,s,3)
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026c", "0?Set(CDR(recordingfile)=)") in new stack
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] bridge_channel.c: Channel PJSIP/100-00000287 left 'simple_bridge' basic-bridge <4b2af75c-f650-4961-a09a-c5d02ad20c1f>
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/siptrunk.vpbx.net.au-0000026c", "PJSIP/100-00000287 montior file= ") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/siptrunk.vpbx.net.au-0000026c", "1?skipagi") in new stack
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] app_stack.c: PJSIP/100-00000287 Internal Gosub(crm-hangup,s,1) start
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx_builtins.c: Goto (macro-hangupcall,s,7)
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/100-00000287", "Sending Hangup to CRM") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/siptrunk.vpbx.net.au-0000026c", "") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026c' in macro 'hangupcall'
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/100-00000287", "HANGUP CAUSE: 16") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026c'
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] app_stack.c: SIP/siptrunk.vpbx.net.au-0000026c Internal Gosub(crm-hangup,s,1) start
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/100-00000287", "0?Set(__CRM_VOICEMAIL=)") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026c", "Sending Hangup to CRM") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/siptrunk.vpbx.net.au-0000026c", "HANGUP CAUSE: 16") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026c", "0?Set(__CRM_VOICEMAIL=)") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/siptrunk.vpbx.net.au-0000026c", "MASTER CHANNEL: 1605845959.1333 = 1605845959.1333") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/siptrunk.vpbx.net.au-0000026c", "0?return") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:6] Set("SIP/siptrunk.vpbx.net.au-0000026c", "__CRM_HANGUP=1") in new stack
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/siptrunk.vpbx.net.au-0000026c", "sangomacrm.agi") in new stack
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/100-00000287", "MASTER CHANNEL: 1605845960.1334 = 1605845959.1333") in new stack
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/100-00000287", "1?return") in new stack
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] pbx_builtins.c: Goto (crm-hangup,s,8)
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/100-00000287", "") in new stack
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] app_stack.c: Spawn extension (macro-dial, s, 1) exited non-zero on 'PJSIP/100-00000287'
- [2020-11-20 04:20:42] VERBOSE[2982][C-000002aa] app_stack.c: PJSIP/100-00000287 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:20:42] VERBOSE[2869][C-000002aa] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
- [2020-11-20 04:20:43] VERBOSE[2869][C-000002aa] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000026c>AGI Script sangomacrm.agi completed, returning 0
- [2020-11-20 04:20:43] VERBOSE[2869][C-000002aa] pbx.c: Executing [s@crm-hangup:8] Return("SIP/siptrunk.vpbx.net.au-0000026c", "") in new stack
- [2020-11-20 04:20:43] VERBOSE[2869][C-000002aa] app_stack.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026c'
- [2020-11-20 04:20:43] VERBOSE[2869][C-000002aa] app_stack.c: SIP/siptrunk.vpbx.net.au-0000026c Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:20:58] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:20:58] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:20:58] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:20:58] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:20:58] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:22:57] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:22:57] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:22:57] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:22:57] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:22:57] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:24:32] VERBOSE[11826][C-000002ac] netsock2.c: Using SIP RTP TOS bits 184
- [2020-11-20 04:24:32] VERBOSE[11826][C-000002ac] netsock2.c: Using SIP RTP CoS mark 5
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [0295536300@from-sip-external:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Received incoming SIP connection from unknown peer to 0295536300") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [0295536300@from-sip-external:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "DID=0295536300") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [0295536300@from-sip-external:3] Goto("SIP/siptrunk.vpbx.net.au-0000026d", "s,1") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (from-sip-external,s,1)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@from-sip-external:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?setlanguage:checkanon") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (from-sip-external,s,2)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@from-sip-external:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CHANNEL(language)=en_AU") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@from-sip-external:3] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?noanonymous") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@from-sip-external:4] Goto("SIP/siptrunk.vpbx.net.au-0000026d", "from-trunk,0295536300,1") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (from-trunk,0295536300,1)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [0295536300@from-trunk:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Catch-All DID Match - Found 0295536300 - You probably want a DID for this.") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [0295536300@from-trunk:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__FROM_DID=0295536300") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [0295536300@from-trunk:3] Goto("SIP/siptrunk.vpbx.net.au-0000026d", "ext-did,s,1") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (ext-did,s,1)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:1] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__DIRECTION=INBOUND") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:2] Gosub("SIP/siptrunk.vpbx.net.au-0000026d", "sub-record-check,s,1(in,s,dontcare)") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?initialized") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__REC_STATUS=INITIALIZED") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:3] Set("SIP/siptrunk.vpbx.net.au-0000026d", "NOW=1605846272") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:4] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__DAY=20") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:5] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__MONTH=11") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:6] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__YEAR=2020") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:7] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__TIMESTR=20201120-042432") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:8] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__FROMEXTEN=unknown") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:9] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__MON_FMT=wav") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Recordings initialized") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(ARG3=dontcare)") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:12] Set("SIP/siptrunk.vpbx.net.au-0000026d", "REC_POLICY_MODE_SAVE=") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(REC_STATUS=NO)") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "2?checkaction") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (sub-record-check,s,17)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?sub-record-check,in,1") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (sub-record-check,in,1)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Inbound Recording Check to s") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [in@sub-record-check:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "FROMEXTEN=unknown") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "10?Set(FROMEXTEN=0417400120)") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/siptrunk.vpbx.net.au-0000026d", "recordcheck,1(dontcare,in,s)") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Starting recording check against dontcare") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/siptrunk.vpbx.net.au-0000026d", "dontcare") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [in@sub-record-check:5] Return("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:3] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CHANNEL(tonezone)=au") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:4] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(__FROM_DID=s)") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:5] Set("SIP/siptrunk.vpbx.net.au-0000026d", "returnhere=1") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:6] Gosub("SIP/siptrunk.vpbx.net.au-0000026d", "app-blacklist-check,s,1()") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?blacklisted") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CALLED_BLACKLIST=1") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:7] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CDR(did)=0295536300") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:8] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:9] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "1 ?Set(CALLERID(name)=0417400120)") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:10] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__MOHCLASS=") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:11] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__REVERSAL_REJECT=FALSE") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:12] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?post-reverse-charge") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (ext-did,s,14)
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:14] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:15] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:16] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:17] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CALLERID(name-pres)=allowed_not_screened") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:18] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CALLERID(num-pres)=allowed_not_screened") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:19] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "CallerID Entry Point") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:20] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__CRM_DIRECTION=INBOUND") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:21] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__CRM_SOURCE=0417400120") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:22] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__CRM_LINKEDID=1605846272.1337") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:23] AGI("SIP/siptrunk.vpbx.net.au-0000026d", "sangomacrm.agi,true") in new stack
- [2020-11-20 04:24:32] VERBOSE[13018][C-000002ac] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000026d>AGI Script sangomacrm.agi completed, returning 0
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:24] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@ext-did:25] Goto("SIP/siptrunk.vpbx.net.au-0000026d", "app-daynight,1,1") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (app-daynight,1,1)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1@app-daynight:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?ext-local,vmu100,1:ext-group,1000,1") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (ext-group,1000,1)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:1] Macro("SIP/siptrunk.vpbx.net.au-0000026d", "user-callerid,") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/siptrunk.vpbx.net.au-0000026d", "TOUCH_MONITOR=1605846272.1337") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "AMPUSER=0417400120") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/siptrunk.vpbx.net.au-0000026d", "HOTDESCKCHAN=siptrunk.vpbx.net.au-0000026d") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/siptrunk.vpbx.net.au-0000026d", "HOTDESKEXTEN=siptrunk.vpbx.net.au") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/siptrunk.vpbx.net.au-0000026d", "HOTDESKCALL=0") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(HOTDESKCALL=1)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(CALLERID(name)=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?report") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?Set(REALCALLERIDNUM=0417400120)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/siptrunk.vpbx.net.au-0000026d", "AMPUSER=") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?limit") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/siptrunk.vpbx.net.au-0000026d", "AMPUSERCIDNAME=") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?report") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (macro-user-callerid,s,29)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:29] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Macro Depth is 1") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?report2:macroerror") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (macro-user-callerid,s,31)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?continue") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:32] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:33] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__TTL=64") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:34] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?continue") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (macro-user-callerid,s,50)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:50] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CALLERID(number)=0417400120") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:51] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CALLERID(name)=0417400120") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?cnum") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:53] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CDR(cnam)=0417400120") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:54] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CDR(cnum)=0417400120") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-user-callerid:55] Set("SIP/siptrunk.vpbx.net.au-0000026d", "CHANNEL(language)=en_AU") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:2] Macro("SIP/siptrunk.vpbx.net.au-0000026d", "blkvm-setifempty,") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?init") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__BLKVM_CHANNEL=SIP/siptrunk.vpbx.net.au-0000026d") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("SIP/siptrunk.vpbx.net.au-0000026d", "SHARED(BLKVM,SIP/siptrunk.vpbx.net.au-0000026d)=TRUE") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("SIP/siptrunk.vpbx.net.au-0000026d", "GOSUB_RETVAL=TRUE") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:3] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?skipov") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (ext-group,1000,6)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:6] Set("SIP/siptrunk.vpbx.net.au-0000026d", "RRNODEST=") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:7] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__NODEST=1000") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:8] GosubIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?sub-rgsetcid,s,1()") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:9] Set("SIP/siptrunk.vpbx.net.au-0000026d", "_CFIGNORE=TRUE") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:10] Set("SIP/siptrunk.vpbx.net.au-0000026d", "_FORWARD_CONTEXT=block-cf") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:11] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__PICKUPMARK=1000") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:12] Gosub("SIP/siptrunk.vpbx.net.au-0000026d", "sub-record-check,s,1(rg,1000,dontcare)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "10?initialized") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (sub-record-check,s,10)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Recordings initialized") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(ARG3=dontcare)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:12] Set("SIP/siptrunk.vpbx.net.au-0000026d", "REC_POLICY_MODE_SAVE=") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(REC_STATUS=NO)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "2?checkaction") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (sub-record-check,s,17)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?sub-record-check,rg,1") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:18] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Generic rg Recording Check - 0417400120 1000") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:19] Gosub("SIP/siptrunk.vpbx.net.au-0000026d", "recordcheck,1(dontcare,rg,1000)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Starting recording check against dontcare") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/siptrunk.vpbx.net.au-0000026d", "dontcare") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@sub-record-check:20] Return("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:13] Set("SIP/siptrunk.vpbx.net.au-0000026d", "RingGroupMethod=ringall") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:14] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__ALT_CONFIRM_MSG=") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:15] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?RGVQANNOUNCE:NORGVQANNOUNCE") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (ext-group,1000,18)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [1000@ext-group:18] Macro("SIP/siptrunk.vpbx.net.au-0000026d", "dial,30,HhTtrQ(ANSWERED_ELSEWHERE),100-113") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:2] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__CRM_SOURCE=0417400120") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:4] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:5] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:6] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(CHANNEL(musicclass)=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:7] AGI("SIP/siptrunk.vpbx.net.au-0000026d", "dialparties.agi") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Starting New Dialparties.agi
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Caller ID name is '0417400120' number is '0417400120'
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: CW Ignore is:
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: CF Ignore is: TRUE
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Methodology of ring is 'ringall'
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Added extension 100 to extension map
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Added extension 113 to extension map
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Extension 100 cf is disabled
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Extension 113 cf is disabled
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Extension 100 do not disturb is disabled
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Extension 113 do not disturb is disabled
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/100
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Ended up with real PJSIP Dial string PJSIP/100/sip:100@192.168.0.53:5060
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: dbset CALLTRACE/100 to 0417400120
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/113
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Ended up with no PJSIP contacts
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: dbset CALLTRACE/113 to 0417400120
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: Filtered ARG3: 100-113
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: RVOL_MODE ''
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: RVOL is:
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: dialparties.agi: RVOLPARENT is:
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000026d>AGI Script dialparties.agi completed, returning 0
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:10] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Returned from dialparties with groups to dial") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:11] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "ringall array ") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:12] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__FMGL_DIAL=") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:13] Set("SIP/siptrunk.vpbx.net.au-0000026d", "LOOPCNT=2") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:14] Set("SIP/siptrunk.vpbx.net.au-0000026d", "ITER=1") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:15] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__EXTTOCALL=100") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Working with 100") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:19] Set("SIP/siptrunk.vpbx.net.au-0000026d", "ITER=2") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?ndloopbegin") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (macro-dial,s,15)
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:15] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__EXTTOCALL=113") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Working with 113") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:19] Set("SIP/siptrunk.vpbx.net.au-0000026d", "ITER=3") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?ndloopbegin") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:21] Macro("SIP/siptrunk.vpbx.net.au-0000026d", "dial-ringall-predial-hook,") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:22] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(ds=PJSIP/100/sip:100@192.168.0.53:5060,30,HhtrQ(ANSWERED_ELSEWHERE)M(auto-blkvm)g)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-dial:23] Dial("SIP/siptrunk.vpbx.net.au-0000026d", "PJSIP/100/sip:100@192.168.0.53:5060,30,HhtrQ(ANSWERED_ELSEWHERE)M(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] app_stack.c: PJSIP/100-0000028a Internal Gosub(func-apply-sipheaders,s,1) start
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/100-0000028a", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/100-0000028a", "Applying SIP Headers to channel PJSIP/100-0000028a") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/100-0000028a", "TECH=PJSIP") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/100-0000028a", "SIPHEADERKEYS=") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/100-0000028a", "0") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] app_while.c: Jumping to priority 13
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/100-0000028a", "") in new stack
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] app_stack.c: Spawn extension (from-internal, 1000, 1) exited non-zero on 'PJSIP/100-0000028a'
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] app_stack.c: PJSIP/100-0000028a Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] app_dial.c: Called PJSIP/100/sip:100@192.168.0.53:5060
- [2020-11-20 04:24:33] VERBOSE[28083] netsock2.c: Using SIP RTP Audio TOS bits 184
- [2020-11-20 04:24:33] VERBOSE[28083] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
- [2020-11-20 04:24:33] VERBOSE[28083] netsock2.c: Using SIP RTP Audio CoS mark 5
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] app_dial.c: PJSIP/100-0000028a is ringing
- [2020-11-20 04:24:33] VERBOSE[13018][C-000002ac] app_dial.c: PJSIP/100-0000028a is ringing
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] app_dial.c: PJSIP/100-0000028a answered SIP/siptrunk.vpbx.net.au-0000026d
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:1] Set("PJSIP/100-0000028a", "__MACRO_RESULT=") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:2] Set("PJSIP/100-0000028a", "CFIGNORE=") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:3] Set("PJSIP/100-0000028a", "MASTER_CHANNEL(CFIGNORE)=") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:4] Set("PJSIP/100-0000028a", "FORWARD_CONTEXT=from-internal") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:5] Set("PJSIP/100-0000028a", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("PJSIP/100-0000028a", "blkvm-clr,") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-clr:1] Set("PJSIP/100-0000028a", "SHARED(BLKVM,SIP/siptrunk.vpbx.net.au-0000026d)=") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-clr:2] Set("PJSIP/100-0000028a", "GOSUB_RETVAL=") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("PJSIP/100-0000028a", "") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("PJSIP/100-0000028a", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=100/sip:100@192.168.0.53:5060)") in new stack
- [2020-11-20 04:24:35] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("PJSIP/100-0000028a", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=)") in new stack
- [2020-11-20 04:24:35] VERBOSE[13138][C-000002ac] bridge_channel.c: Channel PJSIP/100-0000028a joined 'simple_bridge' basic-bridge <083309cd-1362-4442-af99-5c327999f727>
- [2020-11-20 04:24:36] VERBOSE[13018][C-000002ac] bridge_channel.c: Channel SIP/siptrunk.vpbx.net.au-0000026d joined 'simple_bridge' basic-bridge <083309cd-1362-4442-af99-5c327999f727>
- [2020-11-20 04:24:57] NOTICE[1714] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:24:57] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:24:57] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:24:57] NOTICE[15512] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:24:57] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:25:03] VERBOSE[1316][C-000002a9] bridge_channel.c: Channel SIP/COM2-0000026b left 'simple_bridge' basic-bridge <37ed901e-a75e-4953-ac49-da1585821ee9>
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] bridge_channel.c: Channel PJSIP/105-00000286 left 'simple_bridge' basic-bridge <37ed901e-a75e-4953-ac49-da1585821ee9>
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] app_macro.c: Spawn extension (macro-dialout-trunk, s, 34) exited non-zero on 'PJSIP/105-00000286' in macro 'dialout-trunk'
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Spawn extension (from-internal, 0423860412, 12) exited non-zero on 'PJSIP/105-00000286'
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [h@from-internal:1] Macro("PJSIP/105-00000286", "hangupcall") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/105-00000286", "1?theend") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx_builtins.c: Goto (macro-hangupcall,s,3)
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/105-00000286", "0?Set(CDR(recordingfile)=)") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/105-00000286", "SIP/COM2-0000026b montior file= ") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("PJSIP/105-00000286", "1?skipagi") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx_builtins.c: Goto (macro-hangupcall,s,7)
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@macro-hangupcall:7] Hangup("PJSIP/105-00000286", "") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'PJSIP/105-00000286' in macro 'hangupcall'
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/105-00000286'
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] app_stack.c: PJSIP/105-00000286 Internal Gosub(crm-hangup,s,1) start
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/105-00000286", "Sending Hangup to CRM") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/105-00000286", "HANGUP CAUSE: 16") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/105-00000286", "0?Set(__CRM_VOICEMAIL=)") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/105-00000286", "MASTER CHANNEL: 1605845904.1331 = 1605845904.1331") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/105-00000286", "0?return") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:6] Set("PJSIP/105-00000286", "__CRM_HANGUP=1") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:7] AGI("PJSIP/105-00000286", "sangomacrm.agi") in new stack
- [2020-11-20 04:25:03] VERBOSE[943][C-000002a9] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
- [2020-11-20 04:25:04] VERBOSE[943][C-000002a9] res_agi.c: <PJSIP/105-00000286>AGI Script sangomacrm.agi completed, returning 0
- [2020-11-20 04:25:04] VERBOSE[943][C-000002a9] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/105-00000286", "") in new stack
- [2020-11-20 04:25:04] VERBOSE[943][C-000002a9] app_stack.c: Spawn extension (from-internal, h, 1) exited non-zero on 'PJSIP/105-00000286'
- [2020-11-20 04:25:04] VERBOSE[943][C-000002a9] app_stack.c: PJSIP/105-00000286 Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] bridge_channel.c: Channel SIP/siptrunk.vpbx.net.au-0000026d left 'simple_bridge' basic-bridge <083309cd-1362-4442-af99-5c327999f727>
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] app_macro.c: Spawn extension (macro-dial, s, 23) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026d' in macro 'dial'
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Spawn extension (ext-group, 1000, 18) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026d'
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [h@ext-group:1] Macro("SIP/siptrunk.vpbx.net.au-0000026d", "hangupcall,") in new stack
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] bridge_channel.c: Channel PJSIP/100-0000028a left 'simple_bridge' basic-bridge <083309cd-1362-4442-af99-5c327999f727>
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] app_stack.c: PJSIP/100-0000028a Internal Gosub(crm-hangup,s,1) start
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/100-0000028a", "Sending Hangup to CRM") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?theend") in new stack
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/100-0000028a", "HANGUP CAUSE: 16") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (macro-hangupcall,s,3)
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/100-0000028a", "0?Set(__CRM_VOICEMAIL=)") in new stack
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/100-0000028a", "MASTER CHANNEL: 1605846273.1338 = 1605846272.1337") in new stack
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/100-0000028a", "1?return") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(CDR(recordingfile)=)") in new stack
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] pbx_builtins.c: Goto (crm-hangup,s,8)
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/100-0000028a", "") in new stack
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] app_stack.c: Spawn extension (macro-dial, s, 1) exited non-zero on 'PJSIP/100-0000028a'
- [2020-11-20 04:25:07] VERBOSE[13138][C-000002ac] app_stack.c: PJSIP/100-0000028a Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "PJSIP/100-0000028a montior file= ") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "1?skipagi") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx_builtins.c: Goto (macro-hangupcall,s,7)
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026d' in macro 'hangupcall'
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026d'
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] app_stack.c: SIP/siptrunk.vpbx.net.au-0000026d Internal Gosub(crm-hangup,s,1) start
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "Sending Hangup to CRM") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "HANGUP CAUSE: 16") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?Set(__CRM_VOICEMAIL=)") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/siptrunk.vpbx.net.au-0000026d", "MASTER CHANNEL: 1605846272.1337 = 1605846272.1337") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/siptrunk.vpbx.net.au-0000026d", "0?return") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:6] Set("SIP/siptrunk.vpbx.net.au-0000026d", "__CRM_HANGUP=1") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/siptrunk.vpbx.net.au-0000026d", "sangomacrm.agi") in new stack
- [2020-11-20 04:25:07] VERBOSE[13018][C-000002ac] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
- [2020-11-20 04:25:08] VERBOSE[13018][C-000002ac] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000026d>AGI Script sangomacrm.agi completed, returning 0
- [2020-11-20 04:25:08] VERBOSE[13018][C-000002ac] pbx.c: Executing [s@crm-hangup:8] Return("SIP/siptrunk.vpbx.net.au-0000026d", "") in new stack
- [2020-11-20 04:25:08] VERBOSE[13018][C-000002ac] app_stack.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026d'
- [2020-11-20 04:25:08] VERBOSE[13018][C-000002ac] app_stack.c: SIP/siptrunk.vpbx.net.au-0000026d Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:26:19] VERBOSE[11826][C-000002ad] netsock2.c: Using SIP RTP TOS bits 184
- [2020-11-20 04:26:19] VERBOSE[11826][C-000002ad] netsock2.c: Using SIP RTP CoS mark 5
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [0295536300@from-sip-external:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Received incoming SIP connection from unknown peer to 0295536300") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [0295536300@from-sip-external:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "DID=0295536300") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [0295536300@from-sip-external:3] Goto("SIP/siptrunk.vpbx.net.au-0000026e", "s,1") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (from-sip-external,s,1)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@from-sip-external:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?setlanguage:checkanon") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (from-sip-external,s,2)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@from-sip-external:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CHANNEL(language)=en_AU") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@from-sip-external:3] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?noanonymous") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@from-sip-external:4] Goto("SIP/siptrunk.vpbx.net.au-0000026e", "from-trunk,0295536300,1") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (from-trunk,0295536300,1)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [0295536300@from-trunk:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Catch-All DID Match - Found 0295536300 - You probably want a DID for this.") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [0295536300@from-trunk:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__FROM_DID=0295536300") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [0295536300@from-trunk:3] Goto("SIP/siptrunk.vpbx.net.au-0000026e", "ext-did,s,1") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (ext-did,s,1)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:1] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__DIRECTION=INBOUND") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:2] Gosub("SIP/siptrunk.vpbx.net.au-0000026e", "sub-record-check,s,1(in,s,dontcare)") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?initialized") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__REC_STATUS=INITIALIZED") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:3] Set("SIP/siptrunk.vpbx.net.au-0000026e", "NOW=1605846379") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:4] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__DAY=20") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:5] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__MONTH=11") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:6] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__YEAR=2020") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:7] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__TIMESTR=20201120-042619") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:8] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__FROMEXTEN=unknown") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:9] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__MON_FMT=wav") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Recordings initialized") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(ARG3=dontcare)") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:12] Set("SIP/siptrunk.vpbx.net.au-0000026e", "REC_POLICY_MODE_SAVE=") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(REC_STATUS=NO)") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "2?checkaction") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (sub-record-check,s,17)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?sub-record-check,in,1") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (sub-record-check,in,1)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [in@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Inbound Recording Check to s") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [in@sub-record-check:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "FROMEXTEN=unknown") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [in@sub-record-check:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "10?Set(FROMEXTEN=0403272579)") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [in@sub-record-check:4] Gosub("SIP/siptrunk.vpbx.net.au-0000026e", "recordcheck,1(dontcare,in,s)") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Starting recording check against dontcare") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/siptrunk.vpbx.net.au-0000026e", "dontcare") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [in@sub-record-check:5] Return("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:3] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CHANNEL(tonezone)=au") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:4] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(__FROM_DID=s)") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:5] Set("SIP/siptrunk.vpbx.net.au-0000026e", "returnhere=1") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:6] Gosub("SIP/siptrunk.vpbx.net.au-0000026e", "app-blacklist-check,s,1()") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@app-blacklist-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?blacklisted") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@app-blacklist-check:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CALLED_BLACKLIST=1") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@app-blacklist-check:3] Return("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:7] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CDR(did)=0295536300") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:8] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:9] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "1 ?Set(CALLERID(name)=0403272579)") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:10] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__MOHCLASS=") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:11] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__REVERSAL_REJECT=FALSE") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:12] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?post-reverse-charge") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (ext-did,s,14)
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:14] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:15] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:16] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:17] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CALLERID(name-pres)=allowed_not_screened") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:18] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CALLERID(num-pres)=allowed_not_screened") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:19] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "CallerID Entry Point") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:20] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__CRM_DIRECTION=INBOUND") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:21] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__CRM_SOURCE=0403272579") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:22] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__CRM_LINKEDID=1605846379.1339") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:23] AGI("SIP/siptrunk.vpbx.net.au-0000026e", "sangomacrm.agi,true") in new stack
- [2020-11-20 04:26:19] VERBOSE[16531][C-000002ad] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000026e>AGI Script sangomacrm.agi completed, returning 0
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:24] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@ext-did:25] Goto("SIP/siptrunk.vpbx.net.au-0000026e", "app-daynight,1,1") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (app-daynight,1,1)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1@app-daynight:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?ext-local,vmu100,1:ext-group,1000,1") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (ext-group,1000,1)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:1] Macro("SIP/siptrunk.vpbx.net.au-0000026e", "user-callerid,") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:1] Set("SIP/siptrunk.vpbx.net.au-0000026e", "TOUCH_MONITOR=1605846379.1339") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "AMPUSER=0403272579") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:3] Set("SIP/siptrunk.vpbx.net.au-0000026e", "HOTDESCKCHAN=siptrunk.vpbx.net.au-0000026e") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:4] Set("SIP/siptrunk.vpbx.net.au-0000026e", "HOTDESKEXTEN=siptrunk.vpbx.net.au") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:5] Set("SIP/siptrunk.vpbx.net.au-0000026e", "HOTDESKCALL=0") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(HOTDESKCALL=1)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(CALLERID(name)=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?report") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?Set(REALCALLERIDNUM=0403272579)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:10] Set("SIP/siptrunk.vpbx.net.au-0000026e", "AMPUSER=") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?limit") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:12] Set("SIP/siptrunk.vpbx.net.au-0000026e", "AMPUSERCIDNAME=") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?report") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (macro-user-callerid,s,29)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:29] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Macro Depth is 1") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?report2:macroerror") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (macro-user-callerid,s,31)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?continue") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:32] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:33] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__TTL=64") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:34] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?continue") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (macro-user-callerid,s,50)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:50] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CALLERID(number)=0403272579") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:51] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CALLERID(name)=0403272579") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?cnum") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:53] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CDR(cnam)=0403272579") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:54] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CDR(cnum)=0403272579") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-user-callerid:55] Set("SIP/siptrunk.vpbx.net.au-0000026e", "CHANNEL(language)=en_AU") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:2] Macro("SIP/siptrunk.vpbx.net.au-0000026e", "blkvm-setifempty,") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?init") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__BLKVM_CHANNEL=SIP/siptrunk.vpbx.net.au-0000026e") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set("SIP/siptrunk.vpbx.net.au-0000026e", "SHARED(BLKVM,SIP/siptrunk.vpbx.net.au-0000026e)=TRUE") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set("SIP/siptrunk.vpbx.net.au-0000026e", "GOSUB_RETVAL=TRUE") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:3] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?skipov") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (ext-group,1000,6)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:6] Set("SIP/siptrunk.vpbx.net.au-0000026e", "RRNODEST=") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:7] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__NODEST=1000") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:8] GosubIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?sub-rgsetcid,s,1()") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:9] Set("SIP/siptrunk.vpbx.net.au-0000026e", "_CFIGNORE=TRUE") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:10] Set("SIP/siptrunk.vpbx.net.au-0000026e", "_FORWARD_CONTEXT=block-cf") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:11] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__PICKUPMARK=1000") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:12] Gosub("SIP/siptrunk.vpbx.net.au-0000026e", "sub-record-check,s,1(rg,1000,dontcare)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "10?initialized") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (sub-record-check,s,10)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:10] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Recordings initialized") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:11] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(ARG3=dontcare)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:12] Set("SIP/siptrunk.vpbx.net.au-0000026e", "REC_POLICY_MODE_SAVE=") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:13] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(REC_STATUS=NO)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:14] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "2?checkaction") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (sub-record-check,s,17)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:17] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?sub-record-check,rg,1") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:18] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Generic rg Recording Check - 0403272579 1000") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:19] Gosub("SIP/siptrunk.vpbx.net.au-0000026e", "recordcheck,1(dontcare,rg,1000)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Starting recording check against dontcare") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("SIP/siptrunk.vpbx.net.au-0000026e", "dontcare") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [recordcheck@sub-record-check:3] Return("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@sub-record-check:20] Return("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:13] Set("SIP/siptrunk.vpbx.net.au-0000026e", "RingGroupMethod=ringall") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:14] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__ALT_CONFIRM_MSG=") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:15] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?RGVQANNOUNCE:NORGVQANNOUNCE") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (ext-group,1000,18)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [1000@ext-group:18] Macro("SIP/siptrunk.vpbx.net.au-0000026e", "dial,30,HhTtrQ(ANSWERED_ELSEWHERE),100-113") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:2] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__CRM_SOURCE=0403272579") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:4] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:5] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(ALERT_INFO=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:6] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(CHANNEL(musicclass)=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:7] AGI("SIP/siptrunk.vpbx.net.au-0000026e", "dialparties.agi") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Starting New Dialparties.agi
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Caller ID name is '0403272579' number is '0403272579'
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: CW Ignore is:
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: CF Ignore is: TRUE
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Methodology of ring is 'ringall'
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Added extension 100 to extension map
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Added extension 113 to extension map
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Extension 100 cf is disabled
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Extension 113 cf is disabled
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Extension 100 do not disturb is disabled
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Extension 113 do not disturb is disabled
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/100
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Ended up with real PJSIP Dial string PJSIP/100/sip:100@192.168.0.53:5060
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: dbset CALLTRACE/100 to 0403272579
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Discovered PJSIP Endpoint PJSIP/113
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Ended up with no PJSIP contacts
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: dbset CALLTRACE/113 to 0403272579
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: Filtered ARG3: 100-113
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: RVOL_MODE ''
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: RVOL is:
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: dialparties.agi: RVOLPARENT is:
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000026e>AGI Script dialparties.agi completed, returning 0
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:10] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Returned from dialparties with groups to dial") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:11] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "ringall array ") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:12] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__FMGL_DIAL=") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:13] Set("SIP/siptrunk.vpbx.net.au-0000026e", "LOOPCNT=2") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:14] Set("SIP/siptrunk.vpbx.net.au-0000026e", "ITER=1") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:15] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__EXTTOCALL=100") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Working with 100") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:19] Set("SIP/siptrunk.vpbx.net.au-0000026e", "ITER=2") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?ndloopbegin") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (macro-dial,s,15)
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:15] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__EXTTOCALL=113") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:16] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Working with 113") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:17] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:18] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(HASH(__SIPHEADERS,Alert-Info)=Normal;volume=)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:19] Set("SIP/siptrunk.vpbx.net.au-0000026e", "ITER=3") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:20] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?ndloopbegin") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:21] Macro("SIP/siptrunk.vpbx.net.au-0000026e", "dial-ringall-predial-hook,") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial-ringall-predial-hook:1] MacroExit("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:22] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(ds=PJSIP/100/sip:100@192.168.0.53:5060,30,HhtrQ(ANSWERED_ELSEWHERE)M(auto-blkvm)g)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-dial:23] Dial("SIP/siptrunk.vpbx.net.au-0000026e", "PJSIP/100/sip:100@192.168.0.53:5060,30,HhtrQ(ANSWERED_ELSEWHERE)M(auto-blkvm)b(func-apply-sipheaders^s^1),") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] app_stack.c: PJSIP/100-0000028b Internal Gosub(func-apply-sipheaders,s,1) start
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("PJSIP/100-0000028b", "1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("PJSIP/100-0000028b", "Applying SIP Headers to channel PJSIP/100-0000028b") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@func-apply-sipheaders:3] Set("PJSIP/100-0000028b", "TECH=PJSIP") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@func-apply-sipheaders:4] Set("PJSIP/100-0000028b", "SIPHEADERKEYS=") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@func-apply-sipheaders:5] While("PJSIP/100-0000028b", "0") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] app_while.c: Jumping to priority 13
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@func-apply-sipheaders:14] Return("PJSIP/100-0000028b", "") in new stack
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] app_stack.c: Spawn extension (from-internal, 1000, 1) exited non-zero on 'PJSIP/100-0000028b'
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] app_stack.c: PJSIP/100-0000028b Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] app_dial.c: Called PJSIP/100/sip:100@192.168.0.53:5060
- [2020-11-20 04:26:20] VERBOSE[16223] netsock2.c: Using SIP RTP Audio TOS bits 184
- [2020-11-20 04:26:20] VERBOSE[16223] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
- [2020-11-20 04:26:20] VERBOSE[16223] netsock2.c: Using SIP RTP Audio CoS mark 5
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] app_dial.c: PJSIP/100-0000028b is ringing
- [2020-11-20 04:26:20] VERBOSE[16531][C-000002ad] app_dial.c: PJSIP/100-0000028b is ringing
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] app_dial.c: PJSIP/100-0000028b answered SIP/siptrunk.vpbx.net.au-0000026e
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:1] Set("PJSIP/100-0000028b", "__MACRO_RESULT=") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:2] Set("PJSIP/100-0000028b", "CFIGNORE=") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:3] Set("PJSIP/100-0000028b", "MASTER_CHANNEL(CFIGNORE)=") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:4] Set("PJSIP/100-0000028b", "FORWARD_CONTEXT=from-internal") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:5] Set("PJSIP/100-0000028b", "MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:6] Macro("PJSIP/100-0000028b", "blkvm-clr,") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-clr:1] Set("PJSIP/100-0000028b", "SHARED(BLKVM,SIP/siptrunk.vpbx.net.au-0000026e)=") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-clr:2] Set("PJSIP/100-0000028b", "GOSUB_RETVAL=") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-blkvm-clr:3] MacroExit("PJSIP/100-0000028b", "") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:7] ExecIf("PJSIP/100-0000028b", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=100/sip:100@192.168.0.53:5060)") in new stack
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-auto-blkvm:8] ExecIf("PJSIP/100-0000028b", "0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=)") in new stack
- [2020-11-20 04:26:22] VERBOSE[16645][C-000002ad] bridge_channel.c: Channel PJSIP/100-0000028b joined 'simple_bridge' basic-bridge <1b8de326-0067-401b-af3e-8da8a3989cdf>
- [2020-11-20 04:26:22] VERBOSE[16531][C-000002ad] bridge_channel.c: Channel SIP/siptrunk.vpbx.net.au-0000026e joined 'simple_bridge' basic-bridge <1b8de326-0067-401b-af3e-8da8a3989cdf>
- [2020-11-20 04:26:57] NOTICE[13133] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:26:57] NOTICE[15512] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:26:57] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:26:57] NOTICE[7241] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:26:57] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] bridge_channel.c: Channel SIP/siptrunk.vpbx.net.au-0000026e left 'simple_bridge' basic-bridge <1b8de326-0067-401b-af3e-8da8a3989cdf>
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] bridge_channel.c: Channel PJSIP/100-0000028b left 'simple_bridge' basic-bridge <1b8de326-0067-401b-af3e-8da8a3989cdf>
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] app_macro.c: Spawn extension (macro-dial, s, 23) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026e' in macro 'dial'
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] app_stack.c: PJSIP/100-0000028b Internal Gosub(crm-hangup,s,1) start
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] pbx.c: Executing [s@crm-hangup:1] NoOp("PJSIP/100-0000028b", "Sending Hangup to CRM") in new stack
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] pbx.c: Executing [s@crm-hangup:2] NoOp("PJSIP/100-0000028b", "HANGUP CAUSE: 16") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Spawn extension (ext-group, 1000, 18) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026e'
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [h@ext-group:1] Macro("SIP/siptrunk.vpbx.net.au-0000026e", "hangupcall,") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?theend") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (macro-hangupcall,s,3)
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(CDR(recordingfile)=)") in new stack
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] pbx.c: Executing [s@crm-hangup:3] ExecIf("PJSIP/100-0000028b", "0?Set(__CRM_VOICEMAIL=)") in new stack
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] pbx.c: Executing [s@crm-hangup:4] NoOp("PJSIP/100-0000028b", "MASTER CHANNEL: 1605846380.1340 = 1605846379.1339") in new stack
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] pbx.c: Executing [s@crm-hangup:5] GotoIf("PJSIP/100-0000028b", "1?return") in new stack
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] pbx_builtins.c: Goto (crm-hangup,s,8)
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] pbx.c: Executing [s@crm-hangup:8] Return("PJSIP/100-0000028b", "") in new stack
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] app_stack.c: Spawn extension (macro-dial, s, 1) exited non-zero on 'PJSIP/100-0000028b'
- [2020-11-20 04:27:11] VERBOSE[16645][C-000002ad] app_stack.c: PJSIP/100-0000028b Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-hangupcall:4] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "PJSIP/100-0000028b montior file= ") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-hangupcall:5] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "1?skipagi") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx_builtins.c: Goto (macro-hangupcall,s,7)
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@macro-hangupcall:7] Hangup("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] app_macro.c: Spawn extension (macro-hangupcall, s, 7) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026e' in macro 'hangupcall'
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026e'
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] app_stack.c: SIP/siptrunk.vpbx.net.au-0000026e Internal Gosub(crm-hangup,s,1) start
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:1] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "Sending Hangup to CRM") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:2] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "HANGUP CAUSE: 16") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:3] ExecIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?Set(__CRM_VOICEMAIL=)") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:4] NoOp("SIP/siptrunk.vpbx.net.au-0000026e", "MASTER CHANNEL: 1605846379.1339 = 1605846379.1339") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:5] GotoIf("SIP/siptrunk.vpbx.net.au-0000026e", "0?return") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:6] Set("SIP/siptrunk.vpbx.net.au-0000026e", "__CRM_HANGUP=1") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:7] AGI("SIP/siptrunk.vpbx.net.au-0000026e", "sangomacrm.agi") in new stack
- [2020-11-20 04:27:11] VERBOSE[16531][C-000002ad] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
- [2020-11-20 04:27:12] VERBOSE[16531][C-000002ad] res_agi.c: <SIP/siptrunk.vpbx.net.au-0000026e>AGI Script sangomacrm.agi completed, returning 0
- [2020-11-20 04:27:12] VERBOSE[16531][C-000002ad] pbx.c: Executing [s@crm-hangup:8] Return("SIP/siptrunk.vpbx.net.au-0000026e", "") in new stack
- [2020-11-20 04:27:12] VERBOSE[16531][C-000002ad] app_stack.c: Spawn extension (ext-group, h, 1) exited non-zero on 'SIP/siptrunk.vpbx.net.au-0000026e'
- [2020-11-20 04:27:12] VERBOSE[16531][C-000002ad] app_stack.c: SIP/siptrunk.vpbx.net.au-0000026e Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=
- [2020-11-20 04:28:09] VERBOSE[7241] pbx_variables.c: Setting global variable 'SIPDOMAIN' to 'pabx.voip.mpknetwork.net'
- [2020-11-20 04:28:09] VERBOSE[7241] netsock2.c: Using SIP RTP Audio TOS bits 184
- [2020-11-20 04:28:09] VERBOSE[7241] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
- [2020-11-20 04:28:09] VERBOSE[7241] netsock2.c: Using SIP RTP Audio CoS mark 5
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:1] Macro("PJSIP/107-0000028c", "user-callerid,LIMIT,EXTERNAL,") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/107-0000028c", "TOUCH_MONITOR=1605846489.1341") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/107-0000028c", "AMPUSER=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:3] Set("PJSIP/107-0000028c", "HOTDESCKCHAN=107-0000028c") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:4] Set("PJSIP/107-0000028c", "HOTDESKEXTEN=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/107-0000028c", "HOTDESKCALL=0") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:6] ExecIf("PJSIP/107-0000028c", "0?Set(HOTDESKCALL=1)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:7] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(name)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:8] GotoIf("PJSIP/107-0000028c", "0?report") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:9] ExecIf("PJSIP/107-0000028c", "1?Set(REALCALLERIDNUM=107)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/107-0000028c", "AMPUSER=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:11] GotoIf("PJSIP/107-0000028c", "0?limit") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/107-0000028c", "AMPUSERCIDNAME=Chris") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:13] ExecIf("PJSIP/107-0000028c", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:14] GotoIf("PJSIP/107-0000028c", "0?report") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:15] Set("PJSIP/107-0000028c", "AMPUSERCID=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:16] Set("PJSIP/107-0000028c", "__DIAL_OPTIONS=HhTtr") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:17] Set("PJSIP/107-0000028c", "CALLERID(all)="Chris" <107>") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:18] Set("PJSIP/107-0000028c", "HOTDESCKCHAN=107-0000028c") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:19] Set("PJSIP/107-0000028c", "HOTDESKEXTEN=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/107-0000028c", "HOTDESKCALL=0") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:21] ExecIf("PJSIP/107-0000028c", "0?Set(HOTDESKCALL=1)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:22] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(name)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:23] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(all)="" < >)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:24] ExecIf("PJSIP/107-0000028c", "0?Set(CUSDIAL=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:25] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(all)="Chris" <107>)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:26] GotoIf("PJSIP/107-0000028c", "0?limit") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:27] ExecIf("PJSIP/107-0000028c", "1?Set(GROUP(concurrency_limit)=107)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:28] ExecIf("PJSIP/107-0000028c", "0?Set(CHANNEL(language)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:29] NoOp("PJSIP/107-0000028c", "Macro Depth is 1") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:30] GotoIf("PJSIP/107-0000028c", "1?report2:macroerror") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (macro-user-callerid,s,31)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:31] GotoIf("PJSIP/107-0000028c", "1?continue") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (macro-user-callerid,s,50)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:50] Set("PJSIP/107-0000028c", "CALLERID(number)=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:51] Set("PJSIP/107-0000028c", "CALLERID(name)=Chris") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:52] GotoIf("PJSIP/107-0000028c", "0?cnum") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:53] Set("PJSIP/107-0000028c", "CDR(cnam)=Chris") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:54] Set("PJSIP/107-0000028c", "CDR(cnum)=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-user-callerid:55] Set("PJSIP/107-0000028c", "CHANNEL(language)=en_AU") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:2] Gosub("PJSIP/107-0000028c", "sub-record-check,s,1(out,0403272579,dontcare)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/107-0000028c", "0?initialized") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/107-0000028c", "__REC_STATUS=INITIALIZED") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/107-0000028c", "NOW=1605846489") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/107-0000028c", "__DAY=20") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/107-0000028c", "__MONTH=11") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/107-0000028c", "__YEAR=2020") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/107-0000028c", "__TIMESTR=20201120-042809") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/107-0000028c", "__FROMEXTEN=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/107-0000028c", "__MON_FMT=wav") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/107-0000028c", "Recordings initialized") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/107-0000028c", "0?Set(ARG3=dontcare)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/107-0000028c", "REC_POLICY_MODE_SAVE=") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/107-0000028c", "0?Set(REC_STATUS=NO)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/107-0000028c", "3?checkaction") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (sub-record-check,s,17)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/107-0000028c", "1?sub-record-check,out,1") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (sub-record-check,out,1)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [out@sub-record-check:1] NoOp("PJSIP/107-0000028c", "Outbound Recording Check from 107 to 0403272579") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [out@sub-record-check:2] Set("PJSIP/107-0000028c", "RECMODE=dontcare") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [out@sub-record-check:3] ExecIf("PJSIP/107-0000028c", "1?Goto(routewins)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (sub-record-check,out,7)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [out@sub-record-check:7] Gosub("PJSIP/107-0000028c", "recordcheck,1(dontcare,out,0403272579)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/107-0000028c", "Starting recording check against dontcare") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/107-0000028c", "dontcare") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/107-0000028c", "") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [out@sub-record-check:8] Return("PJSIP/107-0000028c", "") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:3] ExecIf("PJSIP/107-0000028c", "0 ?Set(CDR(accountcode)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:4] Set("PJSIP/107-0000028c", "_ROUTEID=1") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:5] Set("PJSIP/107-0000028c", "_ROUTENAME=General") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:6] Set("PJSIP/107-0000028c", "MOHCLASS=default") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:7] ExecIf("PJSIP/107-0000028c", "1?Set(TRUNKCIDOVERRIDE=0295536300)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:8] Set("PJSIP/107-0000028c", "_CALLERIDNAMEINTERNAL=Chris") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:9] Set("PJSIP/107-0000028c", "_CALLERIDNUMINTERNAL=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:10] Set("PJSIP/107-0000028c", "_EMAILNOTIFICATION=FALSE") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:11] Set("PJSIP/107-0000028c", "_NODEST=") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [0403272579@from-internal:12] Macro("PJSIP/107-0000028c", "dialout-trunk,1,0403272579,,off") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:1] Set("PJSIP/107-0000028c", "DIAL_TRUNK=1") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf("PJSIP/107-0000028c", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf("PJSIP/107-0000028c", "0?sub-pincheck,s,1()") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(num)=107)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf("PJSIP/107-0000028c", "0?disabletrunk,1") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:6] Set("PJSIP/107-0000028c", "DIAL_NUMBER=0403272579") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:7] Set("PJSIP/107-0000028c", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:8] Set("PJSIP/107-0000028c", "OUTBOUND_GROUP=OUT_1") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:9] Set("PJSIP/107-0000028c", "DIAL_TRUNK_OPTIONS=T") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf("PJSIP/107-0000028c", "1?nomax") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (macro-dialout-trunk,s,12)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf("PJSIP/107-0000028c", "0?skipoutcid") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:13] Macro("PJSIP/107-0000028c", "outbound-callerid,1") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp("PJSIP/107-0000028c", "107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp("PJSIP/107-0000028c", "") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp("PJSIP/107-0000028c", "off") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERPRES(name-pres)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERPRES(num-pres)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:6] Set("PJSIP/107-0000028c", "HOTDESCKCHAN=107-0000028c") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:7] Set("PJSIP/107-0000028c", "HOTDESKEXTEN=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:8] Set("PJSIP/107-0000028c", "HOTDESKCALL=0") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf("PJSIP/107-0000028c", "0?Set(HOTDESKCALL=1)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(name)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:11] Set("PJSIP/107-0000028c", "ALLOWTHISROUTE=NO") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf("PJSIP/107-0000028c", "0?Set(ALLOWTHISROUTE=YES)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf("PJSIP/107-0000028c", "0?Hangup()") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf("PJSIP/107-0000028c", "0?Set(REALCALLERIDNUM=107)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf("PJSIP/107-0000028c", "0?Set(AMPUSER=107)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf("PJSIP/107-0000028c", "1?normcid") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:20] Set("PJSIP/107-0000028c", "USEROUTCID=") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:21] Set("PJSIP/107-0000028c", "EMERGENCYCID=") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf("PJSIP/107-0000028c", "0?Set(EMERGENCYCID=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:23] Set("PJSIP/107-0000028c", "TRUNKOUTCID=0295536300") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf("PJSIP/107-0000028c", "1?trunkcid") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf("PJSIP/107-0000028c", "1?Set(CALLERID(all)=0295536300)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(all)=)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf("PJSIP/107-0000028c", "1?Set(CALLERID(all)=0295536300)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERID(all)=107)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:34] Set("PJSIP/107-0000028c", "TIOHIDE=no") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:35] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERPRES(name-pres)=prohib_passed_screen)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf("PJSIP/107-0000028c", "0?Set(CALLERPRES(num-pres)=prohib_passed_screen)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:39] Set("PJSIP/107-0000028c", "CDR(outbound_cnum)=0295536300") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-outbound-callerid:40] Set("PJSIP/107-0000028c", "CDR(outbound_cnam)=") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf("PJSIP/107-0000028c", "0?sub-flp-1,s,1()") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:15] Set("PJSIP/107-0000028c", "OUTNUM=0403272579") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:16] Set("PJSIP/107-0000028c", "custom=SIP/COM2") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf("PJSIP/107-0000028c", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf("PJSIP/107-0000028c", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:19] Macro("PJSIP/107-0000028c", "dialout-trunk-predial-hook,") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("PJSIP/107-0000028c", "") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf("PJSIP/107-0000028c", "0?skipcrm") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:21] Set("PJSIP/107-0000028c", "__CRM_DIRECTION=OUTBOUND") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:22] Set("PJSIP/107-0000028c", "__CRM_DESTINATION=0403272579") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:23] Set("PJSIP/107-0000028c", "__CRM_SOURCE=107") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:24] AGI("PJSIP/107-0000028c", "sangomacrm.agi") in new stack
- [2020-11-20 04:28:09] VERBOSE[20063][C-000002ae] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/sangomacrm.agi
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] res_agi.c: <PJSIP/107-0000028c>AGI Script sangomacrm.agi completed, returning 0
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:25] Set("PJSIP/107-0000028c", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:26] NoOp("PJSIP/107-0000028c", "CRM Finished") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:27] GotoIf("PJSIP/107-0000028c", "0?bypass,1") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:28] ExecIf("PJSIP/107-0000028c", "1?Set(CONNECTEDLINE(num,i)=0403272579)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:29] ExecIf("PJSIP/107-0000028c", "1?Set(CONNECTEDLINE(name,i)=CID:0295536300)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:30] ExecIf("PJSIP/107-0000028c", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)0295536300)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:31] GotoIf("PJSIP/107-0000028c", "0?customtrunk") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:32] ExecIf("PJSIP/107-0000028c", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:33] Set("PJSIP/107-0000028c", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@macro-dialout-trunk:34] Dial("PJSIP/107-0000028c", "SIP/COM2/0403272579,300,Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^0403272579^0403272579^1^1605846489^^0295536300)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] netsock2.c: Using SIP RTP TOS bits 184
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] netsock2.c: Using SIP RTP CoS mark 5
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] app_stack.c: SIP/COM2-0000026f Internal Gosub(func-apply-sipheaders,s,1(1)) start
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:1] ExecIf("SIP/COM2-0000026f", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:2] NoOp("SIP/COM2-0000026f", "Applying SIP Headers to channel SIP/COM2-0000026f") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:3] Set("SIP/COM2-0000026f", "TECH=SIP") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:4] Set("SIP/COM2-0000026f", "SIPHEADERKEYS=Alert-Info") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/COM2-0000026f", "1") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:6] Set("SIP/COM2-0000026f", "sipheader=unset") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf("SIP/COM2-0000026f", "1?SIPRemoveHeader(Alert-Info:)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf("SIP/COM2-0000026f", "0?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf("SIP/COM2-0000026f", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:10] ExecIf("SIP/COM2-0000026f", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:11] ExecIf("SIP/COM2-0000026f", "0?SIPAddHeader(Alert-Info:unset)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:12] ExecIf("SIP/COM2-0000026f", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:13] EndWhile("SIP/COM2-0000026f", "") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:5] While("SIP/COM2-0000026f", "0") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@func-apply-sipheaders:14] Return("SIP/COM2-0000026f", "") in new stack
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] app_stack.c: Spawn extension (from-trunk, 0403272579, 1) exited non-zero on 'SIP/COM2-0000026f'
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] app_stack.c: SIP/COM2-0000026f Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
- [2020-11-20 04:28:10] VERBOSE[20063][C-000002ae] app_dial.c: Called SIP/COM2/0403272579
- [2020-11-20 04:28:11] VERBOSE[20063][C-000002ae] app_dial.c: SIP/COM2-0000026f is ringing
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] app_dial.c: SIP/COM2-0000026f answered PJSIP/107-0000028c
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] app_stack.c: SIP/COM2-0000026f Internal Gosub(sub-send-obroute-email,s,1(0403272579,0403272579,1,1605846489,,0295536300)) start
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-send-obroute-email:1] GotoIf("SIP/COM2-0000026f", "0?sendEmail") in new stack
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-send-obroute-email:2] NoOp("SIP/COM2-0000026f", "email notifications disabled..exiting.") in new stack
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] pbx.c: Executing [s@sub-send-obroute-email:3] Return("SIP/COM2-0000026f", "") in new stack
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] app_stack.c: Spawn extension (from-trunk, , 1) exited non-zero on 'SIP/COM2-0000026f'
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] app_stack.c: SIP/COM2-0000026f Internal Gosub(sub-send-obroute-email,s,1(0403272579,0403272579,1,1605846489,,0295536300)) complete GOSUB_RETVAL=
- [2020-11-20 04:28:14] VERBOSE[20265][C-000002ae] bridge_channel.c: Channel SIP/COM2-0000026f joined 'simple_bridge' basic-bridge <35467c7d-2bf7-48bf-a240-4c3fcbff0d16>
- [2020-11-20 04:28:14] VERBOSE[20063][C-000002ae] bridge_channel.c: Channel PJSIP/107-0000028c joined 'simple_bridge' basic-bridge <35467c7d-2bf7-48bf-a240-4c3fcbff0d16>
- [2020-11-20 04:28:57] NOTICE[19480] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:28:57] NOTICE[1040] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:28:57] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:28:57] NOTICE[15512] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:28:57] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:30:57] NOTICE[18887] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '103' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:30:57] NOTICE[28083] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '109' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:30:57] NOTICE[16223] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '115' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:30:57] NOTICE[15512] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '106' does not exist in context 'from-internal' or has no associated hint
- [2020-11-20 04:30:57] NOTICE[3337] res_pjsip_exten_state.c: Endpoint '102' state subscription failed: Extension '110' does not exist in context 'from-internal' or has no associated hint