[2020-05-01 11:45:00] VERBOSE[11632] pbx_variables.c: Setting global variable 'SIPDOMAIN' to '192.168.0.249' [2020-05-01 11:45:00] VERBOSE[11632] netsock2.c: Using SIP RTP Audio TOS bits 184 [2020-05-01 11:45:00] VERBOSE[11632] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field. [2020-05-01 11:45:00] VERBOSE[11632] netsock2.c: Using SIP RTP Audio CoS mark 5 [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [123@from-internal:1] GotoIf("PJSIP/103-00000237", "1?ext-local,123,1:followme-check,123,1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (ext-local,123,1) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [123@ext-local:1] Set("PJSIP/103-00000237", "__RINGTIMER=15") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [123@ext-local:2] Macro("PJSIP/103-00000237", "exten-vm,novm,123,0,0,0") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:1] Macro("PJSIP/103-00000237", "user-callerid,") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/103-00000237", "TOUCH_MONITOR=1588326300.626") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/103-00000237", "AMPUSER=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("PJSIP/103-00000237", "0?report") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("PJSIP/103-00000237", "1?Set(REALCALLERIDNUM=103)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/103-00000237", "AMPUSER=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("PJSIP/103-00000237", "0?limit") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/103-00000237", "AMPUSERCIDNAME=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:8] ExecIf("PJSIP/103-00000237", "0?Set(__CIDMASQUERADING=TRUE)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:9] GotoIf("PJSIP/103-00000237", "0?report") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/103-00000237", "AMPUSERCID=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:11] Set("PJSIP/103-00000237", "__DIAL_OPTIONS=HhTtr") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/103-00000237", "CALLERID(all)="103" <103>") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/103-00000237", "0?limit") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/103-00000237", "0?Set(GROUP(concurrency_limit)=103)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:15] ExecIf("PJSIP/103-00000237", "1?Set(CHANNEL(language)=fr)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:16] NoOp("PJSIP/103-00000237", "Macro Depth is 2") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("PJSIP/103-00000237", "1?report2:macroerror") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-user-callerid,s,18) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("PJSIP/103-00000237", "0?continue") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("PJSIP/103-00000237", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/103-00000237", "__TTL=64") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:21] GotoIf("PJSIP/103-00000237", "1?continue") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-user-callerid,s,37) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:37] Set("PJSIP/103-00000237", "CALLERID(number)=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:38] Set("PJSIP/103-00000237", "CALLERID(name)=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:39] GotoIf("PJSIP/103-00000237", "0?cnum") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:40] Set("PJSIP/103-00000237", "CDR(cnam)=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:41] Set("PJSIP/103-00000237", "CDR(cnum)=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-user-callerid:42] Set("PJSIP/103-00000237", "CHANNEL(language)=fr") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/103-00000237", "RingGroupMethod=none") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/103-00000237", "__EXTTOCALL=123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/103-00000237", "__PICKUPMARK=123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/103-00000237", "RT=") in new stack [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("PJSIP/103-00000237", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("PJSIP/103-00000237", "0?MacroExit()") in new stack [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:8] ExecIf("PJSIP/103-00000237", "0?Gosub(ext-intercom,*80123,1())") in new stack [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:9] ExecIf("PJSIP/103-00000237", "0?MacroExit()") in new stack [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:10] ExecIf("PJSIP/103-00000237", "0?ChanSpy(PJSIP/123,q)") in new stack [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:11] ExecIf("PJSIP/103-00000237", "0?MacroExit()") in new stack [2020-05-01 11:45:00] WARNING[5707][C-00000110] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:12] Gosub("PJSIP/103-00000237", "sub-record-check,s,1(exten,123,dontcare)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/103-00000237", "0?initialized") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/103-00000237", "__REC_STATUS=INITIALIZED") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/103-00000237", "NOW=1588326300") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/103-00000237", "__DAY=01") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/103-00000237", "__MONTH=05") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/103-00000237", "__YEAR=2020") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/103-00000237", "__TIMESTR=20200501-114500") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/103-00000237", "__FROMEXTEN=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/103-00000237", "__MON_FMT=wav") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/103-00000237", "Recordings initialized") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/103-00000237", "0?Set(ARG3=dontcare)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/103-00000237", "REC_POLICY_MODE_SAVE=") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/103-00000237", "0?Set(REC_STATUS=NO)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/103-00000237", "5?checkaction") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (sub-record-check,s,17) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/103-00000237", "1?sub-record-check,exten,1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (sub-record-check,exten,1) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/103-00000237", "Exten Recording Check between 103 and 123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/103-00000237", "CALLTYPE=internal") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/103-00000237", "0?Set(CALLTYPE=)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/103-00000237", "CALLEE=dontcare") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/103-00000237", "0?Set(CALLEE=dontcare)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/103-00000237", "0?callee") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/103-00000237", "1?caller") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (sub-record-check,exten,13) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/103-00000237", "RECMODE=dontcare") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:14] ExecIf("PJSIP/103-00000237", "0?Set(RECMODE=dontcare)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:15] ExecIf("PJSIP/103-00000237", "1?Set(RECMODE=dontcare)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:16] Gosub("PJSIP/103-00000237", "recordcheck,1(dontcare,internal,123)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/103-00000237", "Starting recording check against dontcare") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/103-00000237", "dontcare") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (sub-record-check,recordcheck,3) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/103-00000237", "") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [exten@sub-record-check:17] Return("PJSIP/103-00000237", "") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:13] GotoIf("PJSIP/103-00000237", "1?macrodial") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-exten-vm,s,19) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:19] GosubIf("PJSIP/103-00000237", "0?clrheader,1()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:20] Macro("PJSIP/103-00000237", "dial-one,,HhTtr,123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/103-00000237", "DEXTEN=123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:2] Set("PJSIP/103-00000237", "__CRM_SOURCE=103") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:3] ExecIf("PJSIP/103-00000237", "0?Set(__EXTTOCALL=123)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:4] Set("PJSIP/103-00000237", "DIALSTATUS_CW=") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:5] GosubIf("PJSIP/103-00000237", "0?screen,1()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:6] GosubIf("PJSIP/103-00000237", "0?cf,1()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:7] GotoIf("PJSIP/103-00000237", "1?skip1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-dial-one,s,10) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/103-00000237", "0?nodial") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:11] GotoIf("PJSIP/103-00000237", "0?continue") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:12] ExecIf("PJSIP/103-00000237", "0?Set(D_OPTIONS=g)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:13] Set("PJSIP/103-00000237", "EXTHASCW=ENABLED") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:14] GotoIf("PJSIP/103-00000237", "0?next1:cwinusebusy") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-dial-one,s,26) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:26] GotoIf("PJSIP/103-00000237", "0?next3:continue") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-dial-one,s,28) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:28] GotoIf("PJSIP/103-00000237", "0?nodial") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:29] GosubIf("PJSIP/103-00000237", "1?dstring,1():dlocal,1()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/103-00000237", "DSTRING=") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/103-00000237", "DEVICES=123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/103-00000237", "0?Return()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/103-00000237", "0?Set(DEVICES=23)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/103-00000237", "LOOPCNT=1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/103-00000237", "ITER=1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/103-00000237", "THISDIAL=PJSIP/123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("PJSIP/103-00000237", "1?zap2dahdi,1()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("PJSIP/103-00000237", "0?Return()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("PJSIP/103-00000237", "NEWDIAL=") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("PJSIP/103-00000237", "LOOPCNT2=1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("PJSIP/103-00000237", "ITER2=1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("PJSIP/103-00000237", "THISPART2=PJSIP/123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("PJSIP/103-00000237", "0?Set(THISPART2=DAHDIIP/123)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("PJSIP/103-00000237", "NEWDIAL=PJSIP/123&") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("PJSIP/103-00000237", "ITER2=2") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("PJSIP/103-00000237", "0?begin2") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("PJSIP/103-00000237", "THISDIAL=PJSIP/123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("PJSIP/103-00000237", "") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("PJSIP/103-00000237", "0?docheck") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:10] NoOp("PJSIP/103-00000237", "Debug: Found PJSIP Destination PJSIP/123") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:11] GotoIf("PJSIP/103-00000237", "0?doset") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:12] NoOp("PJSIP/103-00000237", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:13] Set("PJSIP/103-00000237", "THISDIAL=") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/103-00000237", "1?skipset") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-dial-one,dstring,16) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/103-00000237", "ITER=2") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/103-00000237", "0?begin") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/103-00000237", "1?Return()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/103-00000237", "1?nodial") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-dial-one,s,59) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:59] NoOp("PJSIP/103-00000237", "") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:60] ExecIf("PJSIP/103-00000237", "1?Set(DIALSTATUS=NOANSWER)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:61] NoOp("PJSIP/103-00000237", "Returned from dial-one with nothing to call and DIALSTATUS: NOANSWER") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-dial-one:62] MacroExit("PJSIP/103-00000237", "") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:21] Set("PJSIP/103-00000237", "SV_DIALSTATUS=NOANSWER") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:22] GosubIf("PJSIP/103-00000237", "0?docfu,1()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:23] GosubIf("PJSIP/103-00000237", "0?docfb,1()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:24] Set("PJSIP/103-00000237", "DIALSTATUS=NOANSWER") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:25] ExecIf("PJSIP/103-00000237", "0?MacroExit()") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-exten-vm:26] GotoIf("PJSIP/103-00000237", "1?s-NOANSWER,1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-exten-vm,s-NOANSWER,1) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s-NOANSWER@macro-exten-vm:1] GotoIf("PJSIP/103-00000237", "0?exit,1") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s-NOANSWER@macro-exten-vm:2] PlayTones("PJSIP/103-00000237", "congestion") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s-NOANSWER@macro-exten-vm:3] Congestion("PJSIP/103-00000237", "10") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] app_macro.c: Spawn extension (macro-exten-vm, s-NOANSWER, 3) exited non-zero on 'PJSIP/103-00000237' in macro 'exten-vm' [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Spawn extension (ext-local, 123, 2) exited non-zero on 'PJSIP/103-00000237' [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/103-00000237", "hangupcall,") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/103-00000237", "1?theend") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx_builtins.c: Goto (macro-hangupcall,s,3) [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/103-00000237", "0?Set(CDR(recordingfile)=)") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/103-00000237", " monior file= ") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-hangupcall:5] AGI("PJSIP/103-00000237", "attendedtransfer-rec-restart.php,,") in new stack [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php [2020-05-01 11:45:00] VERBOSE[5707][C-00000110] res_agi.c: AGI Script attendedtransfer-rec-restart.php completed, returning 0 [2020-05-01 11:45:01] VERBOSE[5707][C-00000110] pbx.c: Executing [s@macro-hangupcall:6] Hangup("PJSIP/103-00000237", "") in new stack [2020-05-01 11:45:01] VERBOSE[5707][C-00000110] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'PJSIP/103-00000237' in macro 'hangupcall' [2020-05-01 11:45:01] VERBOSE[5707][C-00000110] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/103-00000237' [2020-05-01 11:45:01] VERBOSE[25681] pbx_variables.c: Setting global variable 'SIPDOMAIN' to '192.168.0.249' [2020-05-01 11:45:01] VERBOSE[25681] netsock2.c: Using SIP RTP Audio TOS bits 184 [2020-05-01 11:45:01] VERBOSE[25681] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field. [2020-05-01 11:45:01] VERBOSE[25681] netsock2.c: Using SIP RTP Audio CoS mark 5 [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [123@from-internal:1] GotoIf("PJSIP/103-00000238", "1?ext-local,123,1:followme-check,123,1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (ext-local,123,1) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [123@ext-local:1] Set("PJSIP/103-00000238", "__RINGTIMER=15") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [123@ext-local:2] Macro("PJSIP/103-00000238", "exten-vm,novm,123,0,0,0") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:1] Macro("PJSIP/103-00000238", "user-callerid,") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:1] Set("PJSIP/103-00000238", "TOUCH_MONITOR=1588326301.627") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:2] Set("PJSIP/103-00000238", "AMPUSER=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:3] GotoIf("PJSIP/103-00000238", "0?report") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:4] ExecIf("PJSIP/103-00000238", "1?Set(REALCALLERIDNUM=103)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:5] Set("PJSIP/103-00000238", "AMPUSER=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:6] GotoIf("PJSIP/103-00000238", "0?limit") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:7] Set("PJSIP/103-00000238", "AMPUSERCIDNAME=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:8] ExecIf("PJSIP/103-00000238", "0?Set(__CIDMASQUERADING=TRUE)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:9] GotoIf("PJSIP/103-00000238", "0?report") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:10] Set("PJSIP/103-00000238", "AMPUSERCID=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:11] Set("PJSIP/103-00000238", "__DIAL_OPTIONS=HhTtr") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:12] Set("PJSIP/103-00000238", "CALLERID(all)="103" <103>") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:13] GotoIf("PJSIP/103-00000238", "0?limit") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:14] ExecIf("PJSIP/103-00000238", "0?Set(GROUP(concurrency_limit)=103)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:15] ExecIf("PJSIP/103-00000238", "1?Set(CHANNEL(language)=fr)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:16] NoOp("PJSIP/103-00000238", "Macro Depth is 2") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:17] GotoIf("PJSIP/103-00000238", "1?report2:macroerror") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-user-callerid,s,18) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:18] GotoIf("PJSIP/103-00000238", "0?continue") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:19] ExecIf("PJSIP/103-00000238", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:20] Set("PJSIP/103-00000238", "__TTL=64") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:21] GotoIf("PJSIP/103-00000238", "1?continue") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-user-callerid,s,37) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:37] Set("PJSIP/103-00000238", "CALLERID(number)=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:38] Set("PJSIP/103-00000238", "CALLERID(name)=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:39] GotoIf("PJSIP/103-00000238", "0?cnum") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:40] Set("PJSIP/103-00000238", "CDR(cnam)=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:41] Set("PJSIP/103-00000238", "CDR(cnum)=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-user-callerid:42] Set("PJSIP/103-00000238", "CHANNEL(language)=fr") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:2] Set("PJSIP/103-00000238", "RingGroupMethod=none") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:3] Set("PJSIP/103-00000238", "__EXTTOCALL=123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:4] Set("PJSIP/103-00000238", "__PICKUPMARK=123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:5] Set("PJSIP/103-00000238", "RT=") in new stack [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:6] ExecIf("PJSIP/103-00000238", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:7] ExecIf("PJSIP/103-00000238", "0?MacroExit()") in new stack [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:8] ExecIf("PJSIP/103-00000238", "0?Gosub(ext-intercom,*80123,1())") in new stack [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:9] ExecIf("PJSIP/103-00000238", "0?MacroExit()") in new stack [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:10] ExecIf("PJSIP/103-00000238", "0?ChanSpy(PJSIP/123,q)") in new stack [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:11] ExecIf("PJSIP/103-00000238", "0?MacroExit()") in new stack [2020-05-01 11:45:01] WARNING[5709][C-00000111] chan_sip.c: This function can only be used on SIP channels. [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:12] Gosub("PJSIP/103-00000238", "sub-record-check,s,1(exten,123,dontcare)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:1] GotoIf("PJSIP/103-00000238", "0?initialized") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:2] Set("PJSIP/103-00000238", "__REC_STATUS=INITIALIZED") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:3] Set("PJSIP/103-00000238", "NOW=1588326301") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:4] Set("PJSIP/103-00000238", "__DAY=01") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:5] Set("PJSIP/103-00000238", "__MONTH=05") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:6] Set("PJSIP/103-00000238", "__YEAR=2020") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:7] Set("PJSIP/103-00000238", "__TIMESTR=20200501-114501") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:8] Set("PJSIP/103-00000238", "__FROMEXTEN=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:9] Set("PJSIP/103-00000238", "__MON_FMT=wav") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:10] NoOp("PJSIP/103-00000238", "Recordings initialized") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:11] ExecIf("PJSIP/103-00000238", "0?Set(ARG3=dontcare)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:12] Set("PJSIP/103-00000238", "REC_POLICY_MODE_SAVE=") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:13] ExecIf("PJSIP/103-00000238", "0?Set(REC_STATUS=NO)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:14] GotoIf("PJSIP/103-00000238", "5?checkaction") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (sub-record-check,s,17) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@sub-record-check:17] GotoIf("PJSIP/103-00000238", "1?sub-record-check,exten,1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (sub-record-check,exten,1) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:1] NoOp("PJSIP/103-00000238", "Exten Recording Check between 103 and 123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:2] Set("PJSIP/103-00000238", "CALLTYPE=internal") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:3] ExecIf("PJSIP/103-00000238", "0?Set(CALLTYPE=)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:4] Set("PJSIP/103-00000238", "CALLEE=dontcare") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:5] ExecIf("PJSIP/103-00000238", "0?Set(CALLEE=dontcare)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:6] GotoIf("PJSIP/103-00000238", "0?callee") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:7] GotoIf("PJSIP/103-00000238", "1?caller") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (sub-record-check,exten,13) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:13] Set("PJSIP/103-00000238", "RECMODE=dontcare") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:14] ExecIf("PJSIP/103-00000238", "0?Set(RECMODE=dontcare)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:15] ExecIf("PJSIP/103-00000238", "1?Set(RECMODE=dontcare)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:16] Gosub("PJSIP/103-00000238", "recordcheck,1(dontcare,internal,123)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/103-00000238", "Starting recording check against dontcare") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [recordcheck@sub-record-check:2] Goto("PJSIP/103-00000238", "dontcare") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (sub-record-check,recordcheck,3) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [recordcheck@sub-record-check:3] Return("PJSIP/103-00000238", "") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [exten@sub-record-check:17] Return("PJSIP/103-00000238", "") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:13] GotoIf("PJSIP/103-00000238", "1?macrodial") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-exten-vm,s,19) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:19] GosubIf("PJSIP/103-00000238", "0?clrheader,1()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:20] Macro("PJSIP/103-00000238", "dial-one,,HhTtr,123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:1] Set("PJSIP/103-00000238", "DEXTEN=123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:2] Set("PJSIP/103-00000238", "__CRM_SOURCE=103") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:3] ExecIf("PJSIP/103-00000238", "0?Set(__EXTTOCALL=123)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:4] Set("PJSIP/103-00000238", "DIALSTATUS_CW=") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:5] GosubIf("PJSIP/103-00000238", "0?screen,1()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:6] GosubIf("PJSIP/103-00000238", "0?cf,1()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:7] GotoIf("PJSIP/103-00000238", "1?skip1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-dial-one,s,10) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:10] GotoIf("PJSIP/103-00000238", "0?nodial") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:11] GotoIf("PJSIP/103-00000238", "0?continue") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:12] ExecIf("PJSIP/103-00000238", "0?Set(D_OPTIONS=g)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:13] Set("PJSIP/103-00000238", "EXTHASCW=ENABLED") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:14] GotoIf("PJSIP/103-00000238", "0?next1:cwinusebusy") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-dial-one,s,26) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:26] GotoIf("PJSIP/103-00000238", "0?next3:continue") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-dial-one,s,28) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:28] GotoIf("PJSIP/103-00000238", "0?nodial") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:29] GosubIf("PJSIP/103-00000238", "1?dstring,1():dlocal,1()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:1] Set("PJSIP/103-00000238", "DSTRING=") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:2] Set("PJSIP/103-00000238", "DEVICES=123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/103-00000238", "0?Return()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/103-00000238", "0?Set(DEVICES=23)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:5] Set("PJSIP/103-00000238", "LOOPCNT=1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:6] Set("PJSIP/103-00000238", "ITER=1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:7] Set("PJSIP/103-00000238", "THISDIAL=PJSIP/123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:8] GosubIf("PJSIP/103-00000238", "1?zap2dahdi,1()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:1] ExecIf("PJSIP/103-00000238", "0?Return()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:2] Set("PJSIP/103-00000238", "NEWDIAL=") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:3] Set("PJSIP/103-00000238", "LOOPCNT2=1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:4] Set("PJSIP/103-00000238", "ITER2=1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:5] Set("PJSIP/103-00000238", "THISPART2=PJSIP/123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:6] ExecIf("PJSIP/103-00000238", "0?Set(THISPART2=DAHDIIP/123)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:7] Set("PJSIP/103-00000238", "NEWDIAL=PJSIP/123&") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:8] Set("PJSIP/103-00000238", "ITER2=2") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:9] GotoIf("PJSIP/103-00000238", "0?begin2") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:10] Set("PJSIP/103-00000238", "THISDIAL=PJSIP/123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [zap2dahdi@macro-dial-one:11] Return("PJSIP/103-00000238", "") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:9] GotoIf("PJSIP/103-00000238", "0?docheck") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:10] NoOp("PJSIP/103-00000238", "Debug: Found PJSIP Destination PJSIP/123") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:11] GotoIf("PJSIP/103-00000238", "0?doset") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:12] NoOp("PJSIP/103-00000238", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:13] Set("PJSIP/103-00000238", "THISDIAL=") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/103-00000238", "1?skipset") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-dial-one,dstring,16) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:16] Set("PJSIP/103-00000238", "ITER=2") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/103-00000238", "0?begin") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/103-00000238", "1?Return()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:30] GotoIf("PJSIP/103-00000238", "1?nodial") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-dial-one,s,59) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:59] NoOp("PJSIP/103-00000238", "") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:60] ExecIf("PJSIP/103-00000238", "1?Set(DIALSTATUS=NOANSWER)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:61] NoOp("PJSIP/103-00000238", "Returned from dial-one with nothing to call and DIALSTATUS: NOANSWER") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-dial-one:62] MacroExit("PJSIP/103-00000238", "") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:21] Set("PJSIP/103-00000238", "SV_DIALSTATUS=NOANSWER") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:22] GosubIf("PJSIP/103-00000238", "0?docfu,1()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:23] GosubIf("PJSIP/103-00000238", "0?docfb,1()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:24] Set("PJSIP/103-00000238", "DIALSTATUS=NOANSWER") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:25] ExecIf("PJSIP/103-00000238", "0?MacroExit()") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-exten-vm:26] GotoIf("PJSIP/103-00000238", "1?s-NOANSWER,1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-exten-vm,s-NOANSWER,1) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s-NOANSWER@macro-exten-vm:1] GotoIf("PJSIP/103-00000238", "0?exit,1") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s-NOANSWER@macro-exten-vm:2] PlayTones("PJSIP/103-00000238", "congestion") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s-NOANSWER@macro-exten-vm:3] Congestion("PJSIP/103-00000238", "10") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] app_macro.c: Spawn extension (macro-exten-vm, s-NOANSWER, 3) exited non-zero on 'PJSIP/103-00000238' in macro 'exten-vm' [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Spawn extension (ext-local, 123, 2) exited non-zero on 'PJSIP/103-00000238' [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [h@ext-local:1] Macro("PJSIP/103-00000238", "hangupcall,") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-hangupcall:1] GotoIf("PJSIP/103-00000238", "1?theend") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx_builtins.c: Goto (macro-hangupcall,s,3) [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-hangupcall:3] ExecIf("PJSIP/103-00000238", "0?Set(CDR(recordingfile)=)") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-hangupcall:4] NoOp("PJSIP/103-00000238", " monior file= ") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-hangupcall:5] AGI("PJSIP/103-00000238", "attendedtransfer-rec-restart.php,,") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] res_agi.c: AGI Script attendedtransfer-rec-restart.php completed, returning 0 [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Executing [s@macro-hangupcall:6] Hangup("PJSIP/103-00000238", "") in new stack [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] app_macro.c: Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'PJSIP/103-00000238' in macro 'hangupcall' [2020-05-01 11:45:01] VERBOSE[5709][C-00000111] pbx.c: Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/103-00000238'