[2017-12-25 17:45:35] VERBOSE[2898][C-00000022] netsock2.c: Using SIP RTP TOS bits 184
[2017-12-25 17:45:35] VERBOSE[2898][C-00000022] netsock2.c: Using SIP RTP CoS mark 5
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk-sip-TELFIN:1] Set(“SIP/inbound_telphin-00000022”, “GROUP()=OUT_1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk-sip-TELFIN:2] Goto(“SIP/inbound_telphin-00000022”, “from-trunk,812TRUNKNUMBER,1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (from-trunk,812TRUNKNUMBER,1)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:1] Set(“SIP/inbound_telphin-00000022”, “__DIRECTION=INBOUND”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:2] Gosub(“SIP/inbound_telphin-00000022”, “sub-record-check,s,1(in,812TRUNKNUMBER,dontcare)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/inbound_telphin-00000022”, “0?initialized”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:2] Set(“SIP/inbound_telphin-00000022”, “__REC_STATUS=INITIALIZED”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:3] Set(“SIP/inbound_telphin-00000022”, “NOW=1514213135”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:4] Set(“SIP/inbound_telphin-00000022”, “__DAY=25”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:5] Set(“SIP/inbound_telphin-00000022”, “__MONTH=12”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:6] Set(“SIP/inbound_telphin-00000022”, “__YEAR=2017”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:7] Set(“SIP/inbound_telphin-00000022”, “__TIMESTR=20171225-174535”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:8] Set(“SIP/inbound_telphin-00000022”, “__FROMEXTEN=unknown”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:9] Set(“SIP/inbound_telphin-00000022”, “__MON_FMT=wav”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/inbound_telphin-00000022”, “Recordings initialized”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(ARG3=dontcare)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/inbound_telphin-00000022”, “REC_POLICY_MODE_SAVE=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(REC_STATUS=NO)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/inbound_telphin-00000022”, “2?checkaction”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,s,17)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/inbound_telphin-00000022”, “1?sub-record-check,in,1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,in,1)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [in@sub-record-check:1] NoOp(“SIP/inbound_telphin-00000022”, “Inbound Recording Check to 812TRUNKNUMBER”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [in@sub-record-check:2] Set(“SIP/inbound_telphin-00000022”, “FROMEXTEN=unknown”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [in@sub-record-check:3] ExecIf(“SIP/inbound_telphin-00000022”, “12?Set(FROMEXTEN=+7812MAKECALLFROM)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [in@sub-record-check:4] Gosub(“SIP/inbound_telphin-00000022”, “recordcheck,1(dontcare,in,812TRUNKNUMBER)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/inbound_telphin-00000022”, “Starting recording check against dontcare”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/inbound_telphin-00000022”, “dontcare”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [in@sub-record-check:5] Return(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:3] Gosub(“SIP/inbound_telphin-00000022”, “app-blacklist-check,s,1()”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@app-blacklist-check:1] GotoIf(“SIP/inbound_telphin-00000022”, “0?blacklisted”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@app-blacklist-check:2] Set(“SIP/inbound_telphin-00000022”, “CALLED_BLACKLIST=1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@app-blacklist-check:3] Return(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:4] Set(“SIP/inbound_telphin-00000022”, “__FROM_DID=812TRUNKNUMBER”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:5] Set(“SIP/inbound_telphin-00000022”, “CDR(did)=812TRUNKNUMBER”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:6] ExecIf(“SIP/inbound_telphin-00000022”, “0 ?Set(CALLERID(name)=+7812MAKECALLFROM)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:7] Set(“SIP/inbound_telphin-00000022”, “__MOHCLASS=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:8] Set(“SIP/inbound_telphin-00000022”, “__REVERSAL_REJECT=FALSE”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:9] GotoIf(“SIP/inbound_telphin-00000022”, “1?post-reverse-charge”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (from-trunk,812TRUNKNUMBER,11)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:11] NoOp(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:12] Set(“SIP/inbound_telphin-00000022”, “__CALLINGNAMEPRES_SV=allowed_not_screened”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:13] Set(“SIP/inbound_telphin-00000022”, “__CALLINGNUMPRES_SV=allowed_not_screened”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:14] Set(“SIP/inbound_telphin-00000022”, “CALLERID(name-pres)=allowed_not_screened”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:15] Set(“SIP/inbound_telphin-00000022”, “CALLERID(num-pres)=allowed_not_screened”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:16] NoOp(“SIP/inbound_telphin-00000022”, “CallerID Entry Point”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:17] Set(“SIP/inbound_telphin-00000022”, “__CRM_DIRECTION=INBOUND”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:18] Set(“SIP/inbound_telphin-00000022”, “__CRM_SOURCE=+7812MAKECALLFROM”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:19] Set(“SIP/inbound_telphin-00000022”, “__CRM_LINKEDID=1514213135.125”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:20] ExecIf(“SIP/inbound_telphin-00000022”, “1?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [812TRUNKNUMBER@from-trunk:21] Goto(“SIP/inbound_telphin-00000022”, “from-did-direct,250,1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (from-did-direct,250,1)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@from-did-direct:1] GotoIf(“SIP/inbound_telphin-00000022”, “0?ext-local,250,1:followme-check,250,1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (followme-check,250,1)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-check:1] Gosub(“SIP/inbound_telphin-00000022”, “followme-sub,250,1()”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:1] Macro(“SIP/inbound_telphin-00000022”, “user-callerid,”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:1] Set(“SIP/inbound_telphin-00000022”, “TOUCH_MONITOR=1514213135.125”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:2] Set(“SIP/inbound_telphin-00000022”, “AMPUSER=+7812MAKECALLFROM”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:3] GotoIf(“SIP/inbound_telphin-00000022”, “0?report”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:4] ExecIf(“SIP/inbound_telphin-00000022”, “1?Set(REALCALLERIDNUM=+7812MAKECALLFROM)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:5] Set(“SIP/inbound_telphin-00000022”, “AMPUSER=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:6] GotoIf(“SIP/inbound_telphin-00000022”, “0?limit”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:7] Set(“SIP/inbound_telphin-00000022”, “AMPUSERCIDNAME=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:8] GotoIf(“SIP/inbound_telphin-00000022”, “1?report”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (macro-user-callerid,s,15)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:15] NoOp(“SIP/inbound_telphin-00000022”, “Macro Depth is 1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:16] GotoIf(“SIP/inbound_telphin-00000022”, “1?report2:macroerror”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (macro-user-callerid,s,18)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:18] GotoIf(“SIP/inbound_telphin-00000022”, “0?continue”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:19] Set(“SIP/inbound_telphin-00000022”, “__TTL=64”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:20] GotoIf(“SIP/inbound_telphin-00000022”, “1?continue”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (macro-user-callerid,s,36)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:36] Set(“SIP/inbound_telphin-00000022”, “CALLERID(number)=+7812MAKECALLFROM”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:37] Set(“SIP/inbound_telphin-00000022”, “CALLERID(name)=+7812MAKECALLFROM”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:38] GotoIf(“SIP/inbound_telphin-00000022”, “0?cnum”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:39] Set(“SIP/inbound_telphin-00000022”, “CDR(cnam)=+7812MAKECALLFROM”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:40] Set(“SIP/inbound_telphin-00000022”, “CDR(cnum)=+7812MAKECALLFROM”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-user-callerid:41] Set(“SIP/inbound_telphin-00000022”, “CHANNEL(language)=en”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:2] Set(“SIP/inbound_telphin-00000022”, “DIAL_OPTIONS=TtrI”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:3] Set(“SIP/inbound_telphin-00000022”, “CONNECTEDLINE(num,i)=250”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:4] Gosub(“SIP/inbound_telphin-00000022”, “sub-presencestate-display,s,1(250)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-presencestate-display:1] Goto(“SIP/inbound_telphin-00000022”, “state-not_set,1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-presencestate-display,state-not_set,1)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [state-not_set@sub-presencestate-display:1] Set(“SIP/inbound_telphin-00000022”, “PRESENCESTATE_DISPLAY=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [state-not_set@sub-presencestate-display:2] Return(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:5] Set(“SIP/inbound_telphin-00000022”, “CONNECTEDLINE(name)=250”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:6] Set(“SIP/inbound_telphin-00000022”, “FM_DIALSTATUS=NOT_INUSE”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:7] Set(“SIP/inbound_telphin-00000022”, “__EXTTOCALL=250”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:8] Set(“SIP/inbound_telphin-00000022”, “__PICKUPMARK=250”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:9] Macro(“SIP/inbound_telphin-00000022”, “blkvm-setifempty,”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-blkvm-setifempty:1] GotoIf(“SIP/inbound_telphin-00000022”, “1?init”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (macro-blkvm-setifempty,s,4)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-blkvm-setifempty:4] Set(“SIP/inbound_telphin-00000022”, “__BLKVM_CHANNEL=SIP/inbound_telphin-00000022”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-blkvm-setifempty:5] Set(“SIP/inbound_telphin-00000022”, “SHARED(BLKVM,SIP/inbound_telphin-00000022)=TRUE”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-blkvm-setifempty:6] Set(“SIP/inbound_telphin-00000022”, “GOSUB_RETVAL=TRUE”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-blkvm-setifempty:7] MacroExit(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:10] GotoIf(“SIP/inbound_telphin-00000022”, “1?skipov”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (followme-sub,250,13)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:13] Set(“SIP/inbound_telphin-00000022”, “RRNODEST=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:14] Set(“SIP/inbound_telphin-00000022”, “__NODEST=250”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:15] GosubIf(“SIP/inbound_telphin-00000022”, “0?sub-fmsetcid,s,1()”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:16] GotoIf(“SIP/inbound_telphin-00000022”, “1?skipprepend”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (followme-sub,250,18)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:18] Set(“SIP/inbound_telphin-00000022”, “RecordMethod=Group”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:19] Gosub(“SIP/inbound_telphin-00000022”, “sub-record-check,s,1(exten,250,)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:1] GotoIf(“SIP/inbound_telphin-00000022”, “12?initialized”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,s,10)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:10] NoOp(“SIP/inbound_telphin-00000022”, “Recordings initialized”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:11] ExecIf(“SIP/inbound_telphin-00000022”, “1?Set(ARG3=dontcare)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:12] Set(“SIP/inbound_telphin-00000022”, “REC_POLICY_MODE_SAVE=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:13] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(REC_STATUS=NO)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:14] GotoIf(“SIP/inbound_telphin-00000022”, “5?checkaction”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,s,17)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@sub-record-check:17] GotoIf(“SIP/inbound_telphin-00000022”, “1?sub-record-check,exten,1”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,exten,1)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:1] NoOp(“SIP/inbound_telphin-00000022”, “Exten Recording Check between +7812MAKECALLFROM and 250”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:2] Set(“SIP/inbound_telphin-00000022”, “CALLTYPE=external”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:3] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(CALLTYPE=)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:4] Set(“SIP/inbound_telphin-00000022”, “CALLEE=dontcare”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:5] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(CALLEE=dontcare)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:6] GotoIf(“SIP/inbound_telphin-00000022”, “1?callee”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,exten,11)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:11] Gosub(“SIP/inbound_telphin-00000022”, “recordcheck,1(dontcare,external,250)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“SIP/inbound_telphin-00000022”, “Starting recording check against dontcare”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“SIP/inbound_telphin-00000022”, “dontcare”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [exten@sub-record-check:12] Return(“SIP/inbound_telphin-00000022”, “”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:20] GotoIf(“SIP/inbound_telphin-00000022”, “1?skipdring”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (followme-sub,250,23)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:23] Set(“SIP/inbound_telphin-00000022”, “STRATEGY=ringallv2-prim”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:24] Set(“SIP/inbound_telphin-00000022”, “__RVOL=”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:25] GotoIf(“SIP/inbound_telphin-00000022”, “1?skipsimple”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (followme-sub,250,28)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:28] Set(“SIP/inbound_telphin-00000022”, “RingGroupMethod=ringallv2-prim”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:29] Set(“SIP/inbound_telphin-00000022”, “_FMGRP=250”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:30] GotoIf(“SIP/inbound_telphin-00000022”, “1?DIALGRP”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (followme-sub,250,34)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:34] ExecIf(“SIP/inbound_telphin-00000022”, “1?Set(DOPTS=TtrI):Set(DOPTS=m(Ring)TtI)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:35] GotoIf(“SIP/inbound_telphin-00000022”, “0?doconfirm”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:36] GotoIf(“SIP/inbound_telphin-00000022”, “1?ringallv21”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx_builtins.c: Goto (followme-sub,250,39)
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [250@followme-sub:39] Macro(“SIP/inbound_telphin-00000022”, “dial,10,TtrI,8953FOLLOWMENUMBER#”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-dial:1] NoOp(“SIP/inbound_telphin-00000022”, "Blind Transfer: , Attended Transfer: , User: , Alert Info: ") in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-dial:2] Set(“SIP/inbound_telphin-00000022”, “__CRM_SOURCE=+7812MAKECALLFROM”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-dial:3] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(ALERT_INFO=)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-dial:4] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(ALERT_INFO=)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-dial:5] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(ALERT_INFO=)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-dial:6] ExecIf(“SIP/inbound_telphin-00000022”, “0?Set(CHANNEL(musicclass)=)”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] pbx.c: Executing [s@macro-dial:7] AGI(“SIP/inbound_telphin-00000022”, “dialparties.agi”) in new stack
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] res_agi.c: Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] res_agi.c: dialparties.agi: Starting New Dialparties.agi
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] res_agi.c: dialparties.agi: Caller ID name is ‘+7812MAKECALLFROM’ number is ‘+7812MAKECALLFROM’
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] res_agi.c: dialparties.agi: CW Ignore is:
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] res_agi.c: dialparties.agi: CF Ignore is:
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] res_agi.c: dialparties.agi: CW IN_USE/BUSY is: 1
[2017-12-25 17:45:35] VERBOSE[32003][C-00000022] res_agi.c: dialparties.agi: Methodology of ring is ‘ringallv2-prim’