Code:
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:1] Set("SIP/003271*****-00003c91", "__DIRECTION=INBOUND") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:2] Gosub("SIP/003271*****-00003c91", "sub-record-check,s,1(in,003271*****,dontcare)") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:1] GotoIf("SIP/003271*****-00003c91", "0?initialized") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:2] Set("SIP/003271*****-00003c91", "__REC_STATUS=INITIALIZED") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:3] Set("SIP/003271*****-00003c91", "NOW=1517586486") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:4] Set("SIP/003271*****-00003c91", "__DAY=02") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:5] Set("SIP/003271*****-00003c91", "__MONTH=02") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:6] Set("SIP/003271*****-00003c91", "__YEAR=2018") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:7] Set("SIP/003271*****-00003c91", "__TIMESTR=20180202-164806") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:8] Set("SIP/003271*****-00003c91", "__FROMEXTEN=unknown") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:9] Set("SIP/003271*****-00003c91", "__MON_FMT=wav") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:10] NoOp("SIP/003271*****-00003c91", "Recordings initialized") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:11] ExecIf("SIP/003271*****-00003c91", "0?Set(ARG3=dontcare)") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:12] Set("SIP/003271*****-00003c91", "REC_POLICY_MODE_SAVE=") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:13] ExecIf("SIP/003271*****-00003c91", "0?Set(REC_STATUS=NO)") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:14] GotoIf("SIP/003271*****-00003c91", "2?checkaction") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Goto (sub-record-check,s,17)
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@sub-record-check:17] GotoIf("SIP/003271*****-00003c91", "1?sub-record-check,in,1") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Goto (sub-record-check,in,1)
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [in@sub-record-check:1] NoOp("SIP/003271*****-00003c91", "Inbound Recording Check to 003271*****") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [in@sub-record-check:2] Set("SIP/003271*****-00003c91", "FROMEXTEN=unknown") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [in@sub-record-check:3] ExecIf("SIP/003271*****-00003c91", "13?Set(FROMEXTEN=0032486414057)") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [in@sub-record-check:4] Gosub("SIP/003271*****-00003c91", "recordcheck,1(dontcare,in,003271*****)") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/003271*****-00003c91", "Starting recording check against dontcare") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [recordcheck@sub-record-check:2] Goto("SIP/003271*****-00003c91", "dontcare") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Goto (sub-record-check,recordcheck,3)
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [recordcheck@sub-record-check:3] Return("SIP/003271*****-00003c91", "") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [in@sub-record-check:5] Return("SIP/003271*****-00003c91", "") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:3] Gosub("SIP/003271*****-00003c91", "app-blacklist-check,s,1()") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@app-blacklist-check:1] GotoIf("SIP/003271*****-00003c91", "0?blacklisted") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@app-blacklist-check:2] Set("SIP/003271*****-00003c91", "CALLED_BLACKLIST=1") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [s@app-blacklist-check:3] Return("SIP/003271*****-00003c91", "") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:4] Set("SIP/003271*****-00003c91", "__FROM_DID=003271*****") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:5] Set("SIP/003271*****-00003c91", "CDR(did)=003271*****") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:6] ExecIf("SIP/003271*****-00003c91", "0 ?Set(CALLERID(name)=0032486414057)") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:7] Set("SIP/003271*****-00003c91", "CHANNEL(musicclass)=default") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:8] Set("SIP/003271*****-00003c91", "__MOHCLASS=default") in new stack
[2018-02-02 16:48:06] WARNING[14598][C-00001968] func_channel.c: Unknown or unavailable item requested: 'reversecharge'
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:9] GotoIf("SIP/003271*****-00003c91", "0?macro-hangupcall") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:10] Set("SIP/003271*****-00003c91", "__CALLINGPRES_SV=allowed_not_screened") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:11] Set("SIP/003271*****-00003c91", "CALLERPRES()=allowed_not_screened") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [003271*****@from-trunk:12] Goto("SIP/003271*****-00003c91", "from-did-direct,122,1") in new stack
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Goto (from-did-direct,122,1)
[2018-02-02 16:48:06] VERBOSE[14598][C-00001968] pbx.c: -- Executing [122@from-did-direct:1] GotoIf("SIP/003271*****-00003c91", "0?ext-local,122,1") in new stack