Hi,
Sorry for the late reply.
I have made a test call from Exten 2199 from SERVER_A (which has the CID Num Alias set to 1200) to 1300 on SERVER_B however the true extension number of 2199 was passed over the IAX2 trunk and not the desired 1200 number.
The IAX2 trunk has no outbound CallerID and CID Options is set to Allow Any CID. The outbound route has Intra-Company Enabled.
Internal calls to other extensions on SERVER_A display the CID Num Alais of 1200.
This worked as expected before I upgraded to FreePBX 13.
Any ideas?
thanks,
Fraser.
Originating Server:
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:1] Macro("SIP/2199-00001733", "user-callerid,LIMIT,EXTERNAL,") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:1] Set("SIP/2199-00001733", "TOUCH_MONITOR=SERVER_A-1484834427.7228") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:2] Set("SIP/2199-00001733", "AMPUSER=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:3] GotoIf("SIP/2199-00001733", "0?report") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:4] ExecIf("SIP/2199-00001733", "1?Set(REALCALLERIDNUM=2199)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:5] Set("SIP/2199-00001733", "AMPUSER=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:6] GotoIf("SIP/2199-00001733", "0?limit") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:7] Set("SIP/2199-00001733", "AMPUSERCIDNAME=Fraser Allan") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:8] GotoIf("SIP/2199-00001733", "0?report") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:9] Set("SIP/2199-00001733", "AMPUSERCID=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:10] Set("SIP/2199-00001733", "__DIAL_OPTIONS=Ttr") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:11] Set("SIP/2199-00001733", "CALLERID(all)="Fraser Allan" <2199>") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:12] GotoIf("SIP/2199-00001733", "0?limit") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:13] ExecIf("SIP/2199-00001733", "1?Set(GROUP(concurrency_limit)=2199)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:14] ExecIf("SIP/2199-00001733", "0?Set(CHANNEL(language)=)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:15] GotoIf("SIP/2199-00001733", "1?continue") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Goto (macro-user-callerid,s,29)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:29] Set("SIP/2199-00001733", "CALLERID(number)=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:30] Set("SIP/2199-00001733", "CALLERID(name)=Fraser Allan") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:31] GotoIf("SIP/2199-00001733", "0?cnum") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:32] Set("SIP/2199-00001733", "CDR(cnam)=Fraser Allan") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:33] Set("SIP/2199-00001733", "CDR(cnum)=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:34] Set("SIP/2199-00001733", "CHANNEL(language)=en") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:2] Gosub("SIP/2199-00001733", "sub-record-check,s,1(out,1300,dontcare)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:1] GotoIf("SIP/2199-00001733", "0?initialized") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:2] Set("SIP/2199-00001733", "__REC_STATUS=INITIALIZED") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:3] Set("SIP/2199-00001733", "NOW=1484834427") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:4] Set("SIP/2199-00001733", "__DAY=19") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:5] Set("SIP/2199-00001733", "__MONTH=01") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:6] Set("SIP/2199-00001733", "__YEAR=2017") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:7] Set("SIP/2199-00001733", "__TIMESTR=20170119-140027") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:8] Set("SIP/2199-00001733", "__FROMEXTEN=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:9] Set("SIP/2199-00001733", "__MON_FMT=wav") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:10] NoOp("SIP/2199-00001733", "Recordings initialized") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:11] ExecIf("SIP/2199-00001733", "0?Set(ARG3=dontcare)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:12] Set("SIP/2199-00001733", "REC_POLICY_MODE_SAVE=") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:13] ExecIf("SIP/2199-00001733", "0?Set(REC_STATUS=NO)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:14] GotoIf("SIP/2199-00001733", "3?checkaction") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Goto (sub-record-check,s,17)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:17] GotoIf("SIP/2199-00001733", "1?sub-record-check,out,1") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Goto (sub-record-check,out,1)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:1] NoOp("SIP/2199-00001733", "Outbound Recording Check from 2199 to 1300") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:2] Set("SIP/2199-00001733", "RECMODE=yes") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:3] ExecIf("SIP/2199-00001733", "0?Goto(routewins)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:4] ExecIf("SIP/2199-00001733", "0?Goto(routewins)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:5] Gosub("SIP/2199-00001733", "recordcheck,1(yes,out,1300)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:1] NoOp("SIP/2199-00001733", "Starting recording check against yes") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:2] Goto("SIP/2199-00001733", "yes") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Goto (sub-record-check,recordcheck,9)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:9] ExecIf("SIP/2199-00001733", "0?Return()") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:10] Set("SIP/2199-00001733", "__REC_POLICY_MODE=YES") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:11] Goto("SIP/2199-00001733", "startrec") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Goto (sub-record-check,recordcheck,16)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:16] NoOp("SIP/2199-00001733", "Starting recording: out, 1300") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:17] Set("SIP/2199-00001733", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:18] Set("SIP/2199-00001733", "__CALLFILENAME=out-1300-2199-20170119-140027-SERVER_A-1484834427.7228") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:19] MixMonitor("SIP/2199-00001733", "2017/01/19/out-1300-2199-20170119-140027-SERVER_A-1484834427.7228.wav,ai(LOCAL_MIXMON_ID),") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:20] Set("SIP/2199-00001733", "__MIXMON_ID=0x7f1a345fc4c0") in new stack
[2017-01-19 14:00:27] VERBOSE[138457][C-00000c51] app_mixmonitor.c: Begin MixMonitor Recording SIP/2199-00001733
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:21] Set("SIP/2199-00001733", "__RECORD_ID=SIP/2199-00001733") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:22] Set("SIP/2199-00001733", "__REC_STATUS=RECORDING") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:23] Set("SIP/2199-00001733", "CDR(recordingfile)=out-1300-2199-20170119-140027-SERVER_A-1484834427.7228.wav") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:24] Return("SIP/2199-00001733", "") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:6] Return("SIP/2199-00001733", "") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:3] ExecIf("SIP/2199-00001733", "0 ?Set(CDR(accountcode)=)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:4] Set("SIP/2199-00001733", "INTRACOMPANYROUTE=YES") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:5] Set("SIP/2199-00001733", "MOHCLASS=default") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:6] Set("SIP/2199-00001733", "_NODEST=") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:7] Macro("SIP/2199-00001733", "dialout-trunk,12,1300,,off") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:1] Set("SIP/2199-00001733", "DIAL_TRUNK=12") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:2] GosubIf("SIP/2199-00001733", "0?sub-pincheck,s,1()") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:3] GotoIf("SIP/2199-00001733", "0?disabletrunk,1") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:4] Set("SIP/2199-00001733", "DIAL_NUMBER=1300") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:5] Set("SIP/2199-00001733", "DIAL_TRUNK_OPTIONS=Ttr") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:6] Set("SIP/2199-00001733", "OUTBOUND_GROUP=OUT_12") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:7] GotoIf("SIP/2199-00001733", "1?nomax") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Goto (macro-dialout-trunk,s,9)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:9] GotoIf("SIP/2199-00001733", "1?skipoutcid") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Goto (macro-dialout-trunk,s,12)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:12] GosubIf("SIP/2199-00001733", "0?sub-flp-12,s,1()") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:13] Set("SIP/2199-00001733", "OUTNUM=1300") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:14] Set("SIP/2199-00001733", "custom=IAX2/IAX_SERVER_B") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:15] ExecIf("SIP/2199-00001733", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)Ttr)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:16] ExecIf("SIP/2199-00001733", "0?Set(DIAL_TRUNK_OPTIONS=TtrM(confirm))") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:17] Macro("SIP/2199-00001733", "dialout-trunk-predial-hook,") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:1] MacroExit("SIP/2199-00001733", "") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:18] GotoIf("SIP/2199-00001733", "0?bypass,1") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:19] ExecIf("SIP/2199-00001733", "1?Set(CONNECTEDLINE(num,i)=1300)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:20] ExecIf("SIP/2199-00001733", "1?Set(CONNECTEDLINE(name,i)=CID:2199)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:21] ExecIf("SIP/2199-00001733", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)2199)") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:22] GotoIf("SIP/2199-00001733", "0?customtrunk") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] pbx.c: Executing [[email protected]:23] Dial("SIP/2199-00001733", "IAX2/IAX_SERVER_B/1300,300,Ttr") in new stack
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] app_dial.c: Called IAX2/IAX_SERVER_B/1300
[2017-01-19 14:00:27] VERBOSE[9412][C-00000c51] chan_iax2.c: Call accepted by x.x.y.y:4569 (format ulaw)
[2017-01-19 14:00:27] VERBOSE[9412][C-00000c51] chan_iax2.c: Format for call is (ulaw)
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] app_dial.c: IAX2/IAX_SERVER_B-24158 answered SIP/2199-00001733
[2017-01-19 14:00:27] VERBOSE[138458][C-00000c51] bridge_channel.c: Channel IAX2/IAX_SERVER_B-24158 joined 'simple_bridge' basic-bridge <07292c0a-30f4-420c-b2ce-f27cf58aa0d8>
[2017-01-19 14:00:27] VERBOSE[138456][C-00000c51] bridge_channel.c: Channel SIP/2199-00001733 joined 'simple_bridge' basic-bridge <07292c0a-30f4-420c-b2ce-f27cf58aa0d8>
Receiving Server:
[2017-01-19 14:00:27] VERBOSE[1892] chan_iax2.c: -- Accepting AUTHENTICATED call from x.x.x.x:
> requested format = ulaw,
> requested prefs = (ulaw|alaw|gsm),
> actual format = ulaw,
> host prefs = (ulaw|alaw|gsm),
> priority = mine
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:1] Macro("IAX2/SERVER_A-13082", "user-callerid,") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:1] Set("IAX2/SERVER_A-13082", "TOUCH_MONITOR=SERVER_B-1484834427.15022") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:2] Set("IAX2/SERVER_A-13082", "AMPUSER=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:3] GotoIf("IAX2/SERVER_A-13082", "0?report") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:4] ExecIf("IAX2/SERVER_A-13082", "1?Set(REALCALLERIDNUM=2199)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:5] Set("IAX2/SERVER_A-13082", "AMPUSER=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:6] GotoIf("IAX2/SERVER_A-13082", "0?limit") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:7] Set("IAX2/SERVER_A-13082", "AMPUSERCIDNAME=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:8] GotoIf("IAX2/SERVER_A-13082", "1?report") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Goto (macro-user-callerid,s,16)
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:16] GotoIf("IAX2/SERVER_A-13082", "0?continue") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:17] Set("IAX2/SERVER_A-13082", "__TTL=64") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:18] GotoIf("IAX2/SERVER_A-13082", "1?continue") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Goto (macro-user-callerid,s,29)
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:29] Set("IAX2/SERVER_A-13082", "CALLERID(number)=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:30] Set("IAX2/SERVER_A-13082", "CALLERID(name)=Fraser Allan") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:31] Set("IAX2/SERVER_A-13082", "CDR(cnum)=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:32] Set("IAX2/SERVER_A-13082", "CDR(cnam)=Fraser Allan") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:33] Set("IAX2/SERVER_A-13082", "CHANNEL(language)=en") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:2] Answer("IAX2/SERVER_A-13082", "") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:3] Macro("IAX2/SERVER_A-13082", "blkvm-set,reset") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:1] ExecIf("IAX2/SERVER_A-13082", "1?Set(__BLKVM_CHANNEL=IAX2/SERVER_A-13082)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:2] Set("IAX2/SERVER_A-13082", "SHARED(BLKVM,IAX2/SERVER_A-13082)=TRUE") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:3] Set("IAX2/SERVER_A-13082", "GOSUB_RETVAL=TRUE") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:4] MacroExit("IAX2/SERVER_A-13082", "") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:4] ExecIf("IAX2/SERVER_A-13082", "1?Set(_DIAL_OPTIONS=trM(auto-blkvm))") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:5] Set("IAX2/SERVER_A-13082", "__NODEST=1300") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:6] Set("IAX2/SERVER_A-13082", "QCIDPP=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:7] Set("IAX2/SERVER_A-13082", "VQ_CIDPP=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:8] ExecIf("IAX2/SERVER_A-13082", "0?Macro(prepend-cid,)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:9] Set("IAX2/SERVER_A-13082", "QAINFO=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:10] Set("IAX2/SERVER_A-13082", "VQ_AINFO=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:11] ExecIf("IAX2/SERVER_A-13082", "0?Set(__ALERT_INFO=)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:12] Set("IAX2/SERVER_A-13082", "QJOINMSG=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:13] Set("IAX2/SERVER_A-13082", "VQ_JOINMSG=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:14] Set("IAX2/SERVER_A-13082", "QRINGOPTS=r") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:15] Set("IAX2/SERVER_A-13082", "QRETRY=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:16] Set("IAX2/SERVER_A-13082", "VQ_RETRY=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:17] Set("IAX2/SERVER_A-13082", "QOPTIONS=tr") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:18] Set("IAX2/SERVER_A-13082", "VQ_OPTIONS=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:19] Set("IAX2/SERVER_A-13082", "QGOSUB=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:20] Set("IAX2/SERVER_A-13082", "VQ_GOSUB=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:21] Set("IAX2/SERVER_A-13082", "QAGI=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:22] Set("IAX2/SERVER_A-13082", "VQ_AGI=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:23] Set("IAX2/SERVER_A-13082", "QRULE=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:24] Set("IAX2/SERVER_A-13082", "VQ_RULE=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:25] Set("IAX2/SERVER_A-13082", "QPOSITION=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:26] Set("IAX2/SERVER_A-13082", "VQ_POSITION=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:27] Gosub("IAX2/SERVER_A-13082", "sub-record-check,s,1(q,1300,dontcare)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:1] GotoIf("IAX2/SERVER_A-13082", "0?initialized") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:2] Set("IAX2/SERVER_A-13082", "__REC_STATUS=INITIALIZED") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:3] Set("IAX2/SERVER_A-13082", "NOW=1484834427") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:4] Set("IAX2/SERVER_A-13082", "__DAY=19") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:5] Set("IAX2/SERVER_A-13082", "__MONTH=01") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:6] Set("IAX2/SERVER_A-13082", "__YEAR=2017") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:7] Set("IAX2/SERVER_A-13082", "__TIMESTR=20170119-140027") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:8] Set("IAX2/SERVER_A-13082", "__FROMEXTEN=2199") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:9] Set("IAX2/SERVER_A-13082", "__MON_FMT=wav") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:10] NoOp("IAX2/SERVER_A-13082", "Recordings initialized") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:11] ExecIf("IAX2/SERVER_A-13082", "0?Set(ARG3=dontcare)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:12] Set("IAX2/SERVER_A-13082", "REC_POLICY_MODE_SAVE=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:13] ExecIf("IAX2/SERVER_A-13082", "0?Set(REC_STATUS=NO)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:14] GotoIf("IAX2/SERVER_A-13082", "1?checkaction") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Goto (sub-record-check,s,17)
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:17] GotoIf("IAX2/SERVER_A-13082", "0?sub-record-check,q,1") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:18] NoOp("IAX2/SERVER_A-13082", "Generic q Recording Check - 2199 1300") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:19] Gosub("IAX2/SERVER_A-13082", "recordcheck,1(dontcare,q,1300)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:1] NoOp("IAX2/SERVER_A-13082", "Starting recording check against dontcare") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:2] Goto("IAX2/SERVER_A-13082", "dontcare") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Goto (sub-record-check,recordcheck,3)
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:3] Return("IAX2/SERVER_A-13082", "") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:20] Return("IAX2/SERVER_A-13082", "") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:28] Set("IAX2/SERVER_A-13082", "__CWIGNORE=TRUE") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:29] ExecIf("IAX2/SERVER_A-13082", "0?Playback(, )") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:30] QueueLog("IAX2/SERVER_A-13082", "1300,SERVER_B-1484834427.15022,NONE,DID,") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:31] Set("IAX2/SERVER_A-13082", "QAANNOUNCE=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:32] Set("IAX2/SERVER_A-13082", "VQ_AANNOUNCE=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:33] Set("IAX2/SERVER_A-13082", "QMOH=default") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:34] Set("IAX2/SERVER_A-13082", "VQ_MOH=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:35] ExecIf("IAX2/SERVER_A-13082", "1?Set(__MOHCLASS=default)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:36] ExecIf("IAX2/SERVER_A-13082", "1?Set(CHANNEL(musicclass)=default)") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:37] Set("IAX2/SERVER_A-13082", "QMAXWAIT=20") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:38] Set("IAX2/SERVER_A-13082", "VQ_MAXWAIT=") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:39] Set("IAX2/SERVER_A-13082", "QUEUENUM=1300") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:40] Set("IAX2/SERVER_A-13082", "QUEUEJOINTIME=1484834427") in new stack
[2017-01-19 14:00:27] VERBOSE[11466] pbx.c: -- Executing [[email protected]:41] Queue("IAX2/SERVER_A-13082", "1300,tr,,,20,,,,,") in new stack
....