'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:18] VERBOSE[382] res_agi.c: [2012-09-13 08:23:18]  agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2113
[2012-09-13 08:23:18] VERBOSE[382] res_agi.c: [2012-09-13 08:23:18]     -- <SIP/2113-00000520>AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0
[2012-09-13 08:23:18] VERBOSE[382] pbx.c: [2012-09-13 08:23:18]     -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2113-00000520", "TOUCH_MONITOR=2113_1347517390.1360") in new stack
[2012-09-13 08:23:18] VERBOSE[382] pbx.c: [2012-09-13 08:23:18]     -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2113-00000520", "TOUCH_MIXMONITOR=2113_1347517390.1360") in new stack
[2012-09-13 08:23:18] VERBOSE[382] pbx.c: [2012-09-13 08:23:18]     -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2113-00000520", "0?60") in new stack
[2012-09-13 08:23:18] VERBOSE[382] pbx.c: [2012-09-13 08:23:18]     -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2113-00000520", "agi://127.0.0.1:4573/monitortag") in new stack
[2012-09-13 08:23:20] VERBOSE[32064] app_dial.c: [2012-09-13 08:23:20]     -- SIP/Cav-Joh-002-00000518 answered SIP/2086-00000512
[2012-09-13 08:23:21] VERBOSE[410] res_agi.c: [2012-09-13 08:23:21]  agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:21] WARNING[23923] chan_sip.c: Autodestruct on dialog '4f77ce16-7712b1a5-b6b8f354@192.168.2.146' with owner SIP/2104-0000051a in place (Method: BYE). Rescheduling destruction for 10000 ms
[2012-09-13 08:23:21] VERBOSE[390] res_agi.c: [2012-09-13 08:23:21]  agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2045
[2012-09-13 08:23:21] VERBOSE[390] res_agi.c: [2012-09-13 08:23:21]     -- <SIP/2045-00000521>AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0
[2012-09-13 08:23:21] VERBOSE[390] pbx.c: [2012-09-13 08:23:21]     -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2045-00000521", "TOUCH_MONITOR=2045_1347517392.1361") in new stack
[2012-09-13 08:23:21] VERBOSE[390] pbx.c: [2012-09-13 08:23:21]     -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2045-00000521", "TOUCH_MIXMONITOR=2045_1347517392.1361") in new stack
[2012-09-13 08:23:21] VERBOSE[390] pbx.c: [2012-09-13 08:23:21]     -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2045-00000521", "0?60") in new stack
[2012-09-13 08:23:21] VERBOSE[390] pbx.c: [2012-09-13 08:23:21]     -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2045-00000521", "agi://127.0.0.1:4573/monitortag") in new stack
[2012-09-13 08:23:22] VERBOSE[380] res_agi.c: [2012-09-13 08:23:22]  agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2105
[2012-09-13 08:23:22] VERBOSE[380] res_agi.c: [2012-09-13 08:23:22]     -- <SIP/2105-0000051f>AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2105-0000051f", "CALLFILENAME=2105_1347517390.1359") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2105-0000051f", "2105_1347517390.1359.WAV,ab") in new stack
[2012-09-13 08:23:22] VERBOSE[670] app_mixmonitor.c: [2012-09-13 08:23:22]   == Begin MixMonitor Recording SIP/2105-0000051f
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2105-0000051f", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2105-0000051f", "0?100:62") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (macro-default-dial-cav-joh-002-000918,s,62)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2105-0000051f", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2105-0000051f", "CALLFILENAME=1347517390.1359") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2105-0000051f", "1?65:66") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (macro-default-dial-cav-joh-002-000918,s,65)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2105-0000051f", "1347517390.1359.WAV,ab") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2105-0000051f", "OUT_TRUNK_CIDNUM=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2105-0000051f", "OUT_TRUNK_CIDNAME=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2105-0000051f", "OUT_TRUNK_FORCECID=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2105-0000051f", "all-outgoing-checkcid,s,1") in new stack
[2012-09-13 08:23:22] VERBOSE[672] app_mixmonitor.c: [2012-09-13 08:23:22]   == Begin MixMonitor Recording SIP/2105-0000051f
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2105-0000051f", "ext_cidname=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2105-0000051f", "1?50") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,50)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2105-0000051f", "ext_cidnum=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2105-0000051f", "ext_cidpres=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2105-0000051f", "1?54") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,54)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2105-0000051f", "1?56") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,56)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2105-0000051f", "1?59") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,59)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2105-0000051f", "1?61") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,61)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2105-0000051f", "agentid=5058") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2105-0000051f", "0?69") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2105-0000051f", "agent_cidname=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2105-0000051f", "agent_cidnum=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2105-0000051f", "1?67") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,67)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2105-0000051f", "1?69") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,69)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2105-0000051f", "ext_override=") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2105-0000051f", "1?100") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,100)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2105-0000051f", "1?102") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,102)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2105-0000051f", "1?104") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,104)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2105-0000051f", "0?105:150") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,150)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2105-0000051f", "0?151:175") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,175)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2105-0000051f", "0?176:200") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,200)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2105-0000051f", "1?202") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,202)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2105-0000051f", "1?204") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (all-outgoing-checkcid,s,204)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2105-0000051f", "") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2105-0000051f", "0?75:71") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (macro-default-dial-cav-joh-002-000918,s,71)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2105-0000051f", "0?72:74") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Goto (macro-default-dial-cav-joh-002-000918,s,74)
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2105-0000051f", "CALLSCREEN=NO") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2105-0000051f", "0?79") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2105-0000051f", "0?79") in new stack
[2012-09-13 08:23:22] VERBOSE[380] pbx.c: [2012-09-13 08:23:22]     -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2105-0000051f", "/pw_default_credit_clear,da,,agent-pass") in new stack
[2012-09-13 08:23:22] VERBOSE[380] file.c: [2012-09-13 08:23:22]     -- <SIP/2105-0000051f> Playing 'agent-pass.ulaw' (language 'en')
[2012-09-13 08:23:23] WARNING[23923] chan_sip.c: Autodestruct on dialog '55c1fdee-cfc3ec4f-d726a268@192.168.2.133' with owner SIP/2074-00000434 in place (Method: BYE). Rescheduling destruction for 10000 ms
[2012-09-13 08:23:23] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:23]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:23] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:23]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:23] VERBOSE[682] pbx.c: [2012-09-13 08:23:23]     -- Executing [0784121353@default-default:1] Macro("SIP/2025-00000526", "default-dial-cav-joh-002-000918") in new stack
[2012-09-13 08:23:23] VERBOSE[682] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2025-00000526", "agi://127.0.0.1:4573/extension") in new stack
[2012-09-13 08:23:23] VERBOSE[408] res_agi.c: [2012-09-13 08:23:23]  agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!!
[2012-09-13 08:23:23] VERBOSE[382] res_agi.c: [2012-09-13 08:23:23]  agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2113
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:1] Set("SIP/Cav-Joh-002-0000051e", "CDR(hangupside)=") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:2] Set("SIP/Cav-Joh-002-0000051e", "CDR(hangupcause)=16") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:3] Set("SIP/Cav-Joh-002-0000051e", "CDR(codec1)=slin") in new stack
[2012-09-13 08:23:23] VERBOSE[32244] app_macro.c: [2012-09-13 08:23:23]   == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 81) exited non-zero on 'SIP/2104-0000051a' in macro 'default-dial-cav-joh-002-000918'
[2012-09-13 08:23:23] VERBOSE[382] res_agi.c: [2012-09-13 08:23:23]     -- <SIP/2113-00000520>AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0
[2012-09-13 08:23:23] VERBOSE[32244] pbx.c: [2012-09-13 08:23:23]   == Spawn extension (default-default, 0745243688, 1) exited non-zero on 'SIP/2104-0000051a'
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2113-00000520", "CALLFILENAME=2113_1347517390.1360") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2113-00000520", "2113_1347517390.1360.WAV,ab") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:4] Set("SIP/Cav-Joh-002-0000051e", "CDR(codec2)=slin") in new stack
[2012-09-13 08:23:23] VERBOSE[32248] app_mixmonitor.c: [2012-09-13 08:23:23]   == MixMonitor close filestream
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:5] Set("SIP/Cav-Joh-002-0000051e", "CDR(recvip)=41.221.0.33") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:6] Set("SIP/Cav-Joh-002-0000051e", "CDR(fromchan)=") in new stack
[2012-09-13 08:23:23] VERBOSE[686] app_mixmonitor.c: [2012-09-13 08:23:23]   == Begin MixMonitor Recording SIP/2113-00000520
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:7] Set("SIP/Cav-Joh-002-0000051e", "CDR(uri)=sip:27745243688@41.221.0.37:5070") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:8] Set("SIP/Cav-Joh-002-0000051e", "CDR(useragent)=ECN Megaswitch") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:9] Set("SIP/Cav-Joh-002-0000051e", "CDR(llp)=0.000000") in new stack
[2012-09-13 08:23:23] VERBOSE[32248] app_mixmonitor.c: [2012-09-13 08:23:23]   == End MixMonitor Recording SIP/2104-0000051a
[2012-09-13 08:23:23] VERBOSE[32249] app_mixmonitor.c: [2012-09-13 08:23:23]   == MixMonitor close filestream
[2012-09-13 08:23:23] VERBOSE[32249] app_mixmonitor.c: [2012-09-13 08:23:23]   == End MixMonitor Recording SIP/2104-0000051a
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:10] Set("SIP/Cav-Joh-002-0000051e", "CDR(rlp)=0.000000") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:11] Set("SIP/Cav-Joh-002-0000051e", "CDR(ljitt)=0.040390") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:12] Set("SIP/Cav-Joh-002-0000051e", "CDR(rjitt)=49.000000") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:13] GotoIf("SIP/Cav-Joh-002-0000051e", "0?all-faxnotify,s,1:14") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-hangup,s,14)
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:14] ResetCDR("SIP/Cav-Joh-002-0000051e", "w") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:15] NoCDR("SIP/Cav-Joh-002-0000051e", "") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-hangup:16] Hangup("SIP/Cav-Joh-002-0000051e", "") in new stack
[2012-09-13 08:23:23] VERBOSE[685] pbx.c: [2012-09-13 08:23:23]   == Spawn extension (all-hangup, s, 16) exited non-zero on 'SIP/Cav-Joh-002-0000051e'
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2113-00000520", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2113-00000520", "0?100:62") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (macro-default-dial-cav-joh-002-000918,s,62)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2113-00000520", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2113-00000520", "CALLFILENAME=1347517390.1360") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2113-00000520", "1?65:66") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (macro-default-dial-cav-joh-002-000918,s,65)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2113-00000520", "1347517390.1360.WAV,ab") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2113-00000520", "OUT_TRUNK_CIDNUM=") in new stack
[2012-09-13 08:23:23] VERBOSE[689] app_mixmonitor.c: [2012-09-13 08:23:23]   == Begin MixMonitor Recording SIP/2113-00000520
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2113-00000520", "OUT_TRUNK_CIDNAME=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2113-00000520", "OUT_TRUNK_FORCECID=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2113-00000520", "all-outgoing-checkcid,s,1") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2113-00000520", "ext_cidname=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2113-00000520", "1?50") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,50)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2113-00000520", "ext_cidnum=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2113-00000520", "ext_cidpres=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2113-00000520", "1?54") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,54)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2113-00000520", "1?56") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,56)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2113-00000520", "1?59") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,59)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2113-00000520", "1?61") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,61)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2113-00000520", "agentid=6082") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2113-00000520", "0?69") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2113-00000520", "agent_cidname=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2113-00000520", "agent_cidnum=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2113-00000520", "1?67") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,67)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2113-00000520", "1?69") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,69)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2113-00000520", "ext_override=") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2113-00000520", "1?100") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,100)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2113-00000520", "1?102") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,102)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2113-00000520", "1?104") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,104)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2113-00000520", "0?105:150") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,150)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2113-00000520", "0?151:175") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,175)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2113-00000520", "0?176:200") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,200)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2113-00000520", "1?202") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,202)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2113-00000520", "1?204") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (all-outgoing-checkcid,s,204)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2113-00000520", "") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2113-00000520", "0?75:71") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (macro-default-dial-cav-joh-002-000918,s,71)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2113-00000520", "0?72:74") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Goto (macro-default-dial-cav-joh-002-000918,s,74)
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2113-00000520", "CALLSCREEN=NO") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2113-00000520", "0?79") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2113-00000520", "0?79") in new stack
[2012-09-13 08:23:23] VERBOSE[382] pbx.c: [2012-09-13 08:23:23]     -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2113-00000520", "/pw_default_credit_clear,da,,agent-pass") in new stack
[2012-09-13 08:23:23] VERBOSE[382] file.c: [2012-09-13 08:23:23]     -- <SIP/2113-00000520> Playing 'agent-pass.ulaw' (language 'en')
[2012-09-13 08:23:24] WARNING[23923] chan_sip.c: Autodestruct on dialog '68df57247ba0af7b5a05b03c359b0d30@172.20.8.114:5060' with owner SIP/Cav-Joh-002-000004e3 in place (Method: BYE). Rescheduling destruction for 10000 ms
[2012-09-13 08:23:24] VERBOSE[410] res_agi.c: [2012-09-13 08:23:24]  agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!!
[2012-09-13 08:23:24] VERBOSE[410] res_agi.c: [2012-09-13 08:23:24]     -- <SIP/2093-00000525>AGI Script agi://127.0.0.1:4573/extension completed, returning 0
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:2] Set("SIP/2093-00000525", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:3] GotoIf("SIP/2093-00000525", "0?6000:4") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,4)
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:4] Set("SIP/2093-00000525", "TOUCH_MONITOR=1347517396.1365") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:5] Set("SIP/2093-00000525", "TOUCH_MIXMONITOR=1347517396.1365") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:6] Set("SIP/2093-00000525", "SCOPSERV_DBPUT(default/2093/RepeatDial)=0794783039") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:7] Set("SIP/2093-00000525", "SCOPSERV_DBPUT(default/wrapup/2093/lastcall)=1347517396.1365") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:8] Set("SIP/2093-00000525", "GROUP(OUTGOING_DEFAULT)=2093") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:9] GotoIf("SIP/2093-00000525", "1?12") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,12)
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:12] Set("SIP/2093-00000525", "OUT_TENANT=default") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:13] Set("SIP/2093-00000525", "OUT_EXTEN=27794783039") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:14] Set("SIP/2093-00000525", "OUT_EXTEN_FULL=0794783039") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:15] Set("SIP/2093-00000525", "OUT_FORCECID=0") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:16] Set("SIP/2093-00000525", "OUT_LOOKUPAGI=0") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:17] Set("SIP/2093-00000525", "OUT_LOOKUPCUSTOM=0") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:18] Set("SIP/2093-00000525", "OUT_CIDNUM=") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:19] Set("SIP/2093-00000525", "OUT_CIDNAME=") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:20] Goto("SIP/2093-00000525", "50") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,50)
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:50] GotoIf("SIP/2093-00000525", "1?52") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,52)
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:52] GotoIf("SIP/2093-00000525", "0?56") in new stack
[2012-09-13 08:23:24] VERBOSE[410] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:53] AGI("SIP/2093-00000525", "agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING") in new stack
[2012-09-13 08:23:24] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:24]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:24] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:24]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:24] VERBOSE[695] pbx.c: [2012-09-13 08:23:24]     -- Executing [0114657672@default-default:1] Macro("SIP/2104-00000527", "default-dial-cav-joh-002-000918") in new stack
[2012-09-13 08:23:24] VERBOSE[695] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2104-00000527", "agi://127.0.0.1:4573/extension") in new stack
[2012-09-13 08:23:24] WARNING[23923] chan_sip.c: Autodestruct on dialog '6884d79c-b5790001-d7bc15c2@192.168.2.130' with owner SIP/2064-000004de in place (Method: BYE). Rescheduling destruction for 10000 ms
[2012-09-13 08:23:24] VERBOSE[390] res_agi.c: [2012-09-13 08:23:24]  agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2045
[2012-09-13 08:23:24] VERBOSE[390] res_agi.c: [2012-09-13 08:23:24]     -- <SIP/2045-00000521>AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2045-00000521", "CALLFILENAME=2045_1347517392.1361") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2045-00000521", "2045_1347517392.1361.WAV,ab") in new stack
[2012-09-13 08:23:24] VERBOSE[706] app_mixmonitor.c: [2012-09-13 08:23:24]   == Begin MixMonitor Recording SIP/2045-00000521
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2045-00000521", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2045-00000521", "0?100:62") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,62)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2045-00000521", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2045-00000521", "CALLFILENAME=1347517392.1361") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2045-00000521", "1?65:66") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,65)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2045-00000521", "1347517392.1361.WAV,ab") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2045-00000521", "OUT_TRUNK_CIDNUM=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2045-00000521", "OUT_TRUNK_CIDNAME=") in new stack
[2012-09-13 08:23:24] VERBOSE[707] app_mixmonitor.c: [2012-09-13 08:23:24]   == Begin MixMonitor Recording SIP/2045-00000521
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2045-00000521", "OUT_TRUNK_FORCECID=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2045-00000521", "all-outgoing-checkcid,s,1") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2045-00000521", "ext_cidname=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2045-00000521", "1?50") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,50)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2045-00000521", "ext_cidnum=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2045-00000521", "ext_cidpres=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2045-00000521", "1?54") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,54)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2045-00000521", "1?56") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,56)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2045-00000521", "1?59") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,59)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2045-00000521", "1?61") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,61)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2045-00000521", "agentid=3087") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2045-00000521", "0?69") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2045-00000521", "agent_cidname=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2045-00000521", "agent_cidnum=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2045-00000521", "1?67") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,67)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2045-00000521", "1?69") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,69)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2045-00000521", "ext_override=") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2045-00000521", "1?100") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,100)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2045-00000521", "1?102") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,102)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2045-00000521", "1?104") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,104)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2045-00000521", "0?105:150") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,150)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2045-00000521", "0?151:175") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,175)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2045-00000521", "0?176:200") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,200)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2045-00000521", "1?202") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,202)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2045-00000521", "1?204") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (all-outgoing-checkcid,s,204)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2045-00000521", "") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2045-00000521", "0?75:71") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,71)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2045-00000521", "0?72:74") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Goto (macro-default-dial-cav-joh-002-000918,s,74)
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2045-00000521", "CALLSCREEN=NO") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2045-00000521", "0?79") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2045-00000521", "0?79") in new stack
[2012-09-13 08:23:24] VERBOSE[390] pbx.c: [2012-09-13 08:23:24]     -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2045-00000521", "/pw_default_credit_clear,da,,agent-pass") in new stack
[2012-09-13 08:23:24] VERBOSE[390] file.c: [2012-09-13 08:23:24]     -- <SIP/2045-00000521> Playing 'agent-pass.ulaw' (language 'en')
[2012-09-13 08:23:24] VERBOSE[682] res_agi.c: [2012-09-13 08:23:24]  agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:25] VERBOSE[408] res_agi.c: [2012-09-13 08:23:25]     -- <SIP/2068-00000523>AGI Script agi://127.0.0.1:4573/extension completed, returning 4
[2012-09-13 08:23:25] VERBOSE[408] app_macro.c: [2012-09-13 08:23:25]   == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 1) exited non-zero on 'SIP/2068-00000523' in macro 'default-dial-cav-joh-002-000918'
[2012-09-13 08:23:25] VERBOSE[408] pbx.c: [2012-09-13 08:23:25]   == Spawn extension (default-default, 0736927330, 1) exited non-zero on 'SIP/2068-00000523'
[2012-09-13 08:23:25] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:25]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:25] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:25]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:25] VERBOSE[709] pbx.c: [2012-09-13 08:23:25]     -- Executing [0789942054@default-default:1] Macro("SIP/2023-00000528", "default-dial-cav-joh-002-000918") in new stack
[2012-09-13 08:23:25] VERBOSE[709] pbx.c: [2012-09-13 08:23:25]     -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2023-00000528", "agi://127.0.0.1:4573/extension") in new stack
[2012-09-13 08:23:25] VERBOSE[28017] app_macro.c: [2012-09-13 08:23:25]   == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 81) exited non-zero on 'SIP/2074-00000434' in macro 'default-dial-cav-joh-002-000918'
[2012-09-13 08:23:25] VERBOSE[28017] pbx.c: [2012-09-13 08:23:25]   == Spawn extension (default-default, 0827907684, 1) exited non-zero on 'SIP/2074-00000434'
[2012-09-13 08:23:25] VERBOSE[28021] app_mixmonitor.c: [2012-09-13 08:23:25]   == MixMonitor close filestream
[2012-09-13 08:23:25] VERBOSE[28022] app_mixmonitor.c: [2012-09-13 08:23:25]   == MixMonitor close filestream
[2012-09-13 08:23:25] VERBOSE[28022] app_mixmonitor.c: [2012-09-13 08:23:25]   == End MixMonitor Recording SIP/2074-00000434
[2012-09-13 08:23:25] VERBOSE[28021] app_mixmonitor.c: [2012-09-13 08:23:25]   == End MixMonitor Recording SIP/2074-00000434
[2012-09-13 08:23:26] VERBOSE[410] res_agi.c: [2012-09-13 08:23:26]  agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2093
[2012-09-13 08:23:26] VERBOSE[410] res_agi.c: [2012-09-13 08:23:26]     -- <SIP/2093-00000525>AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0
[2012-09-13 08:23:26] VERBOSE[410] pbx.c: [2012-09-13 08:23:26]     -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2093-00000525", "TOUCH_MONITOR=2093_1347517396.1365") in new stack
[2012-09-13 08:23:26] VERBOSE[410] pbx.c: [2012-09-13 08:23:26]     -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2093-00000525", "TOUCH_MIXMONITOR=2093_1347517396.1365") in new stack
[2012-09-13 08:23:26] VERBOSE[410] pbx.c: [2012-09-13 08:23:26]     -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2093-00000525", "0?60") in new stack
[2012-09-13 08:23:26] VERBOSE[410] pbx.c: [2012-09-13 08:23:26]     -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2093-00000525", "agi://127.0.0.1:4573/monitortag") in new stack
[2012-09-13 08:23:26] VERBOSE[30195] app_macro.c: [2012-09-13 08:23:26]   == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 5014) exited non-zero on 'SIP/2091-000004cd' in macro 'default-dial-cav-joh-002-000918'
[2012-09-13 08:23:26] VERBOSE[30195] pbx.c: [2012-09-13 08:23:26]   == Spawn extension (default-default, 0826392993, 1) exited non-zero on 'SIP/2091-000004cd'
[2012-09-13 08:23:26] VERBOSE[30199] app_mixmonitor.c: [2012-09-13 08:23:26]   == End MixMonitor Recording SIP/2091-000004cd
[2012-09-13 08:23:26] VERBOSE[30200] app_mixmonitor.c: [2012-09-13 08:23:26]   == End MixMonitor Recording SIP/2091-000004cd
[2012-09-13 08:23:26] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:26]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:26] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:26]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:26] VERBOSE[720] pbx.c: [2012-09-13 08:23:26]     -- Executing [0723056864@default-default:1] Macro("SIP/2119-00000529", "default-dial-cav-joh-002-000918") in new stack
[2012-09-13 08:23:26] VERBOSE[720] pbx.c: [2012-09-13 08:23:26]     -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2119-00000529", "agi://127.0.0.1:4573/extension") in new stack
[2012-09-13 08:23:26] VERBOSE[695] res_agi.c: [2012-09-13 08:23:26]  agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:27] VERBOSE[32746] app_dial.c: [2012-09-13 08:23:27]     -- SIP/Cav-Joh-002-00000524 is ringing
[2012-09-13 08:23:27] VERBOSE[380] file.c: [2012-09-13 08:23:27]     -- <SIP/2105-0000051f> Playing 'auth-thankyou.ulaw' (language 'en')
[2012-09-13 08:23:27] VERBOSE[32746] app_dial.c: [2012-09-13 08:23:27]     -- SIP/Cav-Joh-002-00000524 answered SIP/2125-0000051d
[2012-09-13 08:23:27] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:27]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:27] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:27]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:27] VERBOSE[753] pbx.c: [2012-09-13 08:23:27]     -- Executing [0731715827@default-default:1] Macro("SIP/2107-0000052a", "default-dial-cav-joh-002-000918") in new stack
[2012-09-13 08:23:27] VERBOSE[753] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2107-0000052a", "agi://127.0.0.1:4573/extension") in new stack
[2012-09-13 08:23:27] VERBOSE[682] res_agi.c: [2012-09-13 08:23:27]  agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!!
[2012-09-13 08:23:27] VERBOSE[682] res_agi.c: [2012-09-13 08:23:27]     -- <SIP/2025-00000526>AGI Script agi://127.0.0.1:4573/extension completed, returning 0
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:2] Set("SIP/2025-00000526", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:3] GotoIf("SIP/2025-00000526", "0?6000:4") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Goto (macro-default-dial-cav-joh-002-000918,s,4)
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:4] Set("SIP/2025-00000526", "TOUCH_MONITOR=1347517403.1366") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:5] Set("SIP/2025-00000526", "TOUCH_MIXMONITOR=1347517403.1366") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:6] Set("SIP/2025-00000526", "SCOPSERV_DBPUT(default/2025/RepeatDial)=0784121353") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:7] Set("SIP/2025-00000526", "SCOPSERV_DBPUT(default/wrapup/2025/lastcall)=1347517403.1366") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:8] Set("SIP/2025-00000526", "GROUP(OUTGOING_DEFAULT)=2025") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:9] GotoIf("SIP/2025-00000526", "1?12") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Goto (macro-default-dial-cav-joh-002-000918,s,12)
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:12] Set("SIP/2025-00000526", "OUT_TENANT=default") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:13] Set("SIP/2025-00000526", "OUT_EXTEN=27784121353") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:14] Set("SIP/2025-00000526", "OUT_EXTEN_FULL=0784121353") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:15] Set("SIP/2025-00000526", "OUT_FORCECID=0") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:16] Set("SIP/2025-00000526", "OUT_LOOKUPAGI=0") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:17] Set("SIP/2025-00000526", "OUT_LOOKUPCUSTOM=0") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:18] Set("SIP/2025-00000526", "OUT_CIDNUM=") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:19] Set("SIP/2025-00000526", "OUT_CIDNAME=") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:20] Goto("SIP/2025-00000526", "50") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Goto (macro-default-dial-cav-joh-002-000918,s,50)
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:50] GotoIf("SIP/2025-00000526", "1?52") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Goto (macro-default-dial-cav-joh-002-000918,s,52)
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:52] GotoIf("SIP/2025-00000526", "0?56") in new stack
[2012-09-13 08:23:27] VERBOSE[682] pbx.c: [2012-09-13 08:23:27]     -- Executing [s@macro-default-dial-cav-joh-002-000918:53] AGI("SIP/2025-00000526", "agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING") in new stack
[2012-09-13 08:23:28] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:28]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:28] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:28]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:28] VERBOSE[756] pbx.c: [2012-09-13 08:23:28]     -- Executing [0744155731@default-default:1] Macro("SIP/2059-0000052b", "default-dial-cav-joh-002-000918") in new stack
[2012-09-13 08:23:28] VERBOSE[756] pbx.c: [2012-09-13 08:23:28]     -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2059-0000052b", "agi://127.0.0.1:4573/extension") in new stack
[2012-09-13 08:23:28] VERBOSE[709] res_agi.c: [2012-09-13 08:23:28]  agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:28] VERBOSE[380] pbx.c: [2012-09-13 08:23:28]     -- Executing [s@macro-default-dial-cav-joh-002-000918:78] ResetCDR("SIP/2105-0000051f", "") in new stack
[2012-09-13 08:23:28] VERBOSE[380] pbx.c: [2012-09-13 08:23:28]     -- Executing [s@macro-default-dial-cav-joh-002-000918:79] GotoIf("SIP/2105-0000051f", "1?81") in new stack
[2012-09-13 08:23:28] VERBOSE[380] pbx.c: [2012-09-13 08:23:28]     -- Goto (macro-default-dial-cav-joh-002-000918,s,81)
[2012-09-13 08:23:28] VERBOSE[380] pbx.c: [2012-09-13 08:23:28]     -- Executing [s@macro-default-dial-cav-joh-002-000918:81] ExecIf("SIP/2105-0000051f", "1?Dial(SIP/27817722492@Cav-Joh-002,60,gF(all-hangup,s,1)):Dial(SIP/27817722492@Cav-Joh-002,60,gF(all-hangup,s,1)grM(all-call-screening^2105^macro-default-dial-cav-joh-002-000918^s^81))") in new stack
[2012-09-13 08:23:28] VERBOSE[380] netsock2.c: [2012-09-13 08:23:28]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:28] VERBOSE[380] netsock2.c: [2012-09-13 08:23:28]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:28] VERBOSE[380] app_dial.c: [2012-09-13 08:23:28]     -- Called SIP/27817722492@Cav-Joh-002
[2012-09-13 08:23:28] VERBOSE[30286] app_macro.c: [2012-09-13 08:23:28]   == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 81) exited non-zero on 'SIP/2064-000004de' in macro 'default-dial-cav-joh-002-000918'
[2012-09-13 08:23:28] VERBOSE[30286] pbx.c: [2012-09-13 08:23:28]   == Spawn extension (default-default, 0835456507, 1) exited non-zero on 'SIP/2064-000004de'
[2012-09-13 08:23:28] VERBOSE[30291] app_mixmonitor.c: [2012-09-13 08:23:28]   == MixMonitor close filestream
[2012-09-13 08:23:28] VERBOSE[30290] app_mixmonitor.c: [2012-09-13 08:23:28]   == MixMonitor close filestream
[2012-09-13 08:23:28] VERBOSE[30290] app_mixmonitor.c: [2012-09-13 08:23:28]   == End MixMonitor Recording SIP/2064-000004de
[2012-09-13 08:23:28] VERBOSE[30291] app_mixmonitor.c: [2012-09-13 08:23:28]   == End MixMonitor Recording SIP/2064-000004de
[2012-09-13 08:23:29] VERBOSE[390] file.c: [2012-09-13 08:23:29]     -- <SIP/2045-00000521> Playing 'auth-thankyou.ulaw' (language 'en')
[2012-09-13 08:23:29] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:29]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:29] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:29]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:1] Set("SIP/Cav-Joh-002-0000052d", "CDR(tenant)=default") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:2] Set("SIP/Cav-Joh-002-0000052d", "__INCOMING_DNIS=1234") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:3] Set("SIP/Cav-Joh-002-0000052d", "LINE_TENANT=default") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:4] Set("SIP/Cav-Joh-002-0000052d", "LINE_PROGRESS=") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:5] Set("SIP/Cav-Joh-002-0000052d", "LINE_SIPHEADER=") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:6] Set("SIP/Cav-Joh-002-0000052d", "LINE_RDNIS=") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:7] Set("SIP/Cav-Joh-002-0000052d", "LINE_SPAMFILTER=") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:8] Set("SIP/Cav-Joh-002-0000052d", "LINE_CHANSPY=") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:9] Set("SIP/Cav-Joh-002-0000052d", "LINE_PICKUPMARK=") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:10] Set("SIP/Cav-Joh-002-0000052d", "LINE_LANGUAGE=en") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:11] Set("SIP/Cav-Joh-002-0000052d", "LINE_MOH=default") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:12] Gosub("SIP/Cav-Joh-002-0000052d", "all-incoming-check,s,1") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:1] NoOp("SIP/Cav-Joh-002-0000052d", ""INCOMING CALL FROM CALLER ID: +27744808047 (27744808047)"") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:2] GotoIf("SIP/Cav-Joh-002-0000052d", "1?7") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,7)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:7] GotoIf("SIP/Cav-Joh-002-0000052d", "1?10") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,10)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:10] GotoIf("SIP/Cav-Joh-002-0000052d", "1?12") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,12)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:12] GotoIf("SIP/Cav-Joh-002-0000052d", "1?14") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,14)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:14] GotoIf("SIP/Cav-Joh-002-0000052d", "1?16") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,16)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:16] GotoIf("SIP/Cav-Joh-002-0000052d", "0?18") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:17] Set("SIP/Cav-Joh-002-0000052d", "CHANNEL(musicclass)=default") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:18] Set("SIP/Cav-Joh-002-0000052d", "CALLERID(dnid)=1234") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:19] Set("SIP/Cav-Joh-002-0000052d", "CDR(userfield)=1234") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:20] Set("SIP/Cav-Joh-002-0000052d", "__EXTCONTEXT=default-default") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:21] Set("SIP/Cav-Joh-002-0000052d", "__INCOMINGLINE=1") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:22] Set("SIP/Cav-Joh-002-0000052d", "__ORGCALLID=1347517409.1373") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:23] GotoIf("SIP/Cav-Joh-002-0000052d", "1?25") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,25)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:25] GotoIf("SIP/Cav-Joh-002-0000052d", "1?27") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,27)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:27] GotoIf("SIP/Cav-Joh-002-0000052d", "1?29") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,29)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:29] GotoIf("SIP/Cav-Joh-002-0000052d", "1?31") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,31)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:31] AGI("SIP/Cav-Joh-002-0000052d", "agi://127.0.0.1:4573/fixcidname") in new stack
[2012-09-13 08:23:29] VERBOSE[767] res_agi.c: [2012-09-13 08:23:29]     -- <SIP/Cav-Joh-002-0000052d>AGI Script agi://127.0.0.1:4573/fixcidname completed, returning 0
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:32] GotoIf("SIP/Cav-Joh-002-0000052d", "1?34") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,34)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:34] GotoIf("SIP/Cav-Joh-002-0000052d", "0?36") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:35] Set("SIP/Cav-Joh-002-0000052d", "CHANNEL(language)=en") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:36] Set("SIP/Cav-Joh-002-0000052d", "FAXNUMBER=1234") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:37] GotoIf("SIP/Cav-Joh-002-0000052d", "1?39") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,39)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:39] GotoIf("SIP/Cav-Joh-002-0000052d", "1?41") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,41)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:41] GotoIf("SIP/Cav-Joh-002-0000052d", "1?44") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,44)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:44] GotoIf("SIP/Cav-Joh-002-0000052d", "1?49") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,49)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:49] GotoIf("SIP/Cav-Joh-002-0000052d", "1?54") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,54)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:54] GotoIf("SIP/Cav-Joh-002-0000052d", "1?56") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,56)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:56] GotoIf("SIP/Cav-Joh-002-0000052d", "1?58") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,58)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:58] GotoIf("SIP/Cav-Joh-002-0000052d", "1?62") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-incoming-check,s,62)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:62] NoOp("SIP/Cav-Joh-002-0000052d", ""NEW CALLER ID: +27744808047 (27744808047)"") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-incoming-check:63] Return("SIP/Cav-Joh-002-0000052d", "") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:13] Set("SIP/Cav-Joh-002-0000052d", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:14] Set("SIP/Cav-Joh-002-0000052d", "CALLFILENAME=1347517409.1373") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:15] MixMonitor("SIP/Cav-Joh-002-0000052d", "1347517409.1373.WAV,ab") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:16] Answer("SIP/Cav-Joh-002-0000052d", "") in new stack
[2012-09-13 08:23:29] VERBOSE[769] app_mixmonitor.c: [2012-09-13 08:23:29]   == Begin MixMonitor Recording SIP/Cav-Joh-002-0000052d
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:17] Goto("SIP/Cav-Joh-002-0000052d", "50") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (default-cav-joh-002-incoming,1234,50)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:50] Set("SIP/Cav-Joh-002-0000052d", "QUEUE_PRIO=0") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:51] Set("SIP/Cav-Joh-002-0000052d", "QUEUE_RULE=") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [1234@default-cav-joh-002-incoming:52] Gosub("SIP/Cav-Joh-002-0000052d", "default-application-acd-prodepartment,s,1") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-0000052d", "HANGUPSIDE=CALLEE") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-0000052d", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-0000052d", ""=== START QUEUE (default-prodepartment) ==="") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-0000052d", "__QUEUENAME=default-prodepartment") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-0000052d", "1?8") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Goto (default-application-acd-prodepartment,s,8)
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-0000052d", "MONITOR_FILENAME=1347517409.1373") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-0000052d", "TIMEOUT(digit)=1") in new stack
[2012-09-13 08:23:29] VERBOSE[767] func_timeout.c: [2012-09-13 08:23:29]     -- Digit timeout set to 1.000
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-0000052d", "TIMEOUT(response)=1") in new stack
[2012-09-13 08:23:29] VERBOSE[767] func_timeout.c: [2012-09-13 08:23:29]     -- Response timeout set to 1.000
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-0000052d", "__ACD_TO_OUTGOING=1") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-0000052d", "CHANNEL(musicclass)=default") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-0000052d", "__ALLOW_TRANSFER=t") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-0000052d", "CHANNEL(language)=en") in new stack
[2012-09-13 08:23:29] VERBOSE[767] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-0000052d", "default-prodepartment,t,,,10,,,,,,") in new stack
[2012-09-13 08:23:29] VERBOSE[767] res_musiconhold.c: [2012-09-13 08:23:29]     -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-0000052d'
[2012-09-13 08:23:29] VERBOSE[767] app_queue.c: [2012-09-13 08:23:29]     -- Called Local/2005@default-agent/n
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:1] NoCDR("Local/2005@default-agent-00000018;2", "") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:2] GotoIf("Local/2005@default-agent-00000018;2", "0?4") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:3] GotoIf("Local/2005@default-agent-00000018;2", "0?40") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:4] Set("Local/2005@default-agent-00000018;2", "GLOBAL(LASTCALL_AGENT_DEFAULT_2005)=1347517409") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]   == Setting global variable 'LASTCALL_AGENT_DEFAULT_2005' to '1347517409'
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:5] Set("Local/2005@default-agent-00000018;2", "GROUPCOUNT=0") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:6] Set("Local/2005@default-agent-00000018;2", "AGENTMAXCALL=") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:7] GotoIf("Local/2005@default-agent-00000018;2", "1?8:11") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Goto (default-agent,2005,8)
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:8] Set("Local/2005@default-agent-00000018;2", "AGENTMAXCALL=") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:9] GotoIf("Local/2005@default-agent-00000018;2", "1?10:11") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Goto (default-agent,2005,10)
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:10] Set("Local/2005@default-agent-00000018;2", "AGENTMAXCALL=1") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:11] GotoIf("Local/2005@default-agent-00000018;2", "0?40") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:12] GotoIf("Local/2005@default-agent-00000018;2", "1?15") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Goto (default-agent,2005,15)
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:15] Set("Local/2005@default-agent-00000018;2", "DND=") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:16] GotoIf("Local/2005@default-agent-00000018;2", "0?40") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:17] Set("Local/2005@default-agent-00000018;2", "OutOffice=") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:18] GotoIf("Local/2005@default-agent-00000018;2", "0?40") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:19] Set("Local/2005@default-agent-00000018;2", "OUTBOUND_GROUP_ONCE=2005@INCOMING_DEFAULT") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:20] Set("Local/2005@default-agent-00000018;2", "__ORGCALLID=1347517409.1373") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:21] Set("Local/2005@default-agent-00000018;2", "SCOPSERV_DBPUT(default/wrapup/2005/lastcall)=1347517409.1373") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:22] Set("Local/2005@default-agent-00000018;2", "AGENTMONITOR=") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:23] GotoIf("Local/2005@default-agent-00000018;2", "1?27") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Goto (default-agent,2005,27)
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:27] Set("Local/2005@default-agent-00000018;2", "CHANNEL(musicclass)=default") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-agent:28] Goto("Local/2005@default-agent-00000018;2", "default-local-devices,2005,1") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Goto (default-local-devices,2005,1)
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-local-devices:1] Set("Local/2005@default-agent-00000018;2", "LOCAL_EXTEN=2005") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-local-devices:2] Set("Local/2005@default-agent-00000018;2", "LOCAL_TENANT=DEFAULT") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-local-devices:3] Set("Local/2005@default-agent-00000018;2", "LOCAL_TENANT2=default") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-local-devices:4] Gosub("Local/2005@default-agent-00000018;2", "all-local-extension,device,1") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [device@all-local-extension:1] Set("Local/2005@default-agent-00000018;2", "__PICKUPMARK=2005") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [device@all-local-extension:2] Set("Local/2005@default-agent-00000018;2", "__ORGCALLID=1347517409.1373") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [device@all-local-extension:3] Set("Local/2005@default-agent-00000018;2", "SCOPSERV_DBPUT(default/wrapup/2005/lastcall)=1347517409.1373") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [device@all-local-extension:4] Return("Local/2005@default-agent-00000018;2", "") in new stack
[2012-09-13 08:23:29] VERBOSE[770] pbx.c: [2012-09-13 08:23:29]     -- Executing [2005@default-local-devices:5] Dial("Local/2005@default-agent-00000018;2", "SIP/2005,,t") in new stack
[2012-09-13 08:23:29] VERBOSE[770] netsock2.c: [2012-09-13 08:23:29]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:29] VERBOSE[770] netsock2.c: [2012-09-13 08:23:29]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:29] VERBOSE[770] app_dial.c: [2012-09-13 08:23:29]     -- Called SIP/2005
[2012-09-13 08:23:29] VERBOSE[770] app_dial.c: [2012-09-13 08:23:29]     -- SIP/2005-0000052e is ringing
[2012-09-13 08:23:29] VERBOSE[767] app_queue.c: [2012-09-13 08:23:29]     -- Local/2005@default-agent-00000018;1 is ringing
[2012-09-13 08:23:29] VERBOSE[410] res_agi.c: [2012-09-13 08:23:29]  agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2093
[2012-09-13 08:23:29] VERBOSE[410] res_agi.c: [2012-09-13 08:23:29]     -- <SIP/2093-00000525>AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2093-00000525", "CALLFILENAME=2093_1347517396.1365") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2093-00000525", "2093_1347517396.1365.WAV,ab") in new stack
[2012-09-13 08:23:29] VERBOSE[771] app_mixmonitor.c: [2012-09-13 08:23:29]   == Begin MixMonitor Recording SIP/2093-00000525
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2093-00000525", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2093-00000525", "0?100:62") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (macro-default-dial-cav-joh-002-000918,s,62)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2093-00000525", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2093-00000525", "CALLFILENAME=1347517396.1365") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2093-00000525", "1?65:66") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (macro-default-dial-cav-joh-002-000918,s,65)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2093-00000525", "1347517396.1365.WAV,ab") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2093-00000525", "OUT_TRUNK_CIDNUM=") in new stack
[2012-09-13 08:23:29] VERBOSE[772] app_mixmonitor.c: [2012-09-13 08:23:29]   == Begin MixMonitor Recording SIP/2093-00000525
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2093-00000525", "OUT_TRUNK_CIDNAME=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2093-00000525", "OUT_TRUNK_FORCECID=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2093-00000525", "all-outgoing-checkcid,s,1") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2093-00000525", "ext_cidname=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2093-00000525", "1?50") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,50)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2093-00000525", "ext_cidnum=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2093-00000525", "ext_cidpres=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2093-00000525", "1?54") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,54)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2093-00000525", "1?56") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,56)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2093-00000525", "1?59") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,59)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2093-00000525", "1?61") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,61)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2093-00000525", "agentid=5114") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2093-00000525", "0?69") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2093-00000525", "agent_cidname=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2093-00000525", "agent_cidnum=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2093-00000525", "1?67") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,67)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2093-00000525", "1?69") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,69)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2093-00000525", "ext_override=") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2093-00000525", "1?100") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,100)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2093-00000525", "1?102") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,102)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2093-00000525", "1?104") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,104)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2093-00000525", "0?105:150") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,150)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2093-00000525", "0?151:175") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,175)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2093-00000525", "0?176:200") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,200)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2093-00000525", "1?202") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,202)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2093-00000525", "1?204") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (all-outgoing-checkcid,s,204)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2093-00000525", "") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2093-00000525", "0?75:71") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (macro-default-dial-cav-joh-002-000918,s,71)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2093-00000525", "0?72:74") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Goto (macro-default-dial-cav-joh-002-000918,s,74)
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2093-00000525", "CALLSCREEN=NO") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2093-00000525", "0?79") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2093-00000525", "0?79") in new stack
[2012-09-13 08:23:29] VERBOSE[410] pbx.c: [2012-09-13 08:23:29]     -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2093-00000525", "/pw_default_credit_clear,da,,agent-pass") in new stack
[2012-09-13 08:23:30] VERBOSE[410] file.c: [2012-09-13 08:23:30]     -- <SIP/2093-00000525> Playing 'agent-pass.ulaw' (language 'en')
[2012-09-13 08:23:30] VERBOSE[390] pbx.c: [2012-09-13 08:23:30]     -- Executing [s@macro-default-dial-cav-joh-002-000918:78] ResetCDR("SIP/2045-00000521", "") in new stack
[2012-09-13 08:23:30] VERBOSE[390] pbx.c: [2012-09-13 08:23:30]     -- Executing [s@macro-default-dial-cav-joh-002-000918:79] GotoIf("SIP/2045-00000521", "1?81") in new stack
[2012-09-13 08:23:30] VERBOSE[390] pbx.c: [2012-09-13 08:23:30]     -- Goto (macro-default-dial-cav-joh-002-000918,s,81)
[2012-09-13 08:23:30] VERBOSE[390] pbx.c: [2012-09-13 08:23:30]     -- Executing [s@macro-default-dial-cav-joh-002-000918:81] ExecIf("SIP/2045-00000521", "1?Dial(SIP/27844668427@Cav-Joh-002,60,gF(all-hangup,s,1)):Dial(SIP/27844668427@Cav-Joh-002,60,gF(all-hangup,s,1)grM(all-call-screening^2045^macro-default-dial-cav-joh-002-000918^s^81))") in new stack
[2012-09-13 08:23:30] VERBOSE[390] netsock2.c: [2012-09-13 08:23:30]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:30] VERBOSE[390] netsock2.c: [2012-09-13 08:23:30]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:30] VERBOSE[390] app_dial.c: [2012-09-13 08:23:30]     -- Called SIP/27844668427@Cav-Joh-002
[2012-09-13 08:23:30] VERBOSE[720] res_agi.c: [2012-09-13 08:23:30]  agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:30] VERBOSE[32054] app_dial.c: [2012-09-13 08:23:30]     -- SIP/Cav-Joh-002-00000516 answered SIP/2126-0000050f
[2012-09-13 08:23:31] VERBOSE[695] res_agi.c: [2012-09-13 08:23:31]  agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!!
[2012-09-13 08:23:31] VERBOSE[695] res_agi.c: [2012-09-13 08:23:31]     -- <SIP/2104-00000527>AGI Script agi://127.0.0.1:4573/extension completed, returning 0
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:2] Set("SIP/2104-00000527", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:3] GotoIf("SIP/2104-00000527", "0?6000:4") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Goto (macro-default-dial-cav-joh-002-000918,s,4)
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:4] Set("SIP/2104-00000527", "TOUCH_MONITOR=1347517404.1367") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:5] Set("SIP/2104-00000527", "TOUCH_MIXMONITOR=1347517404.1367") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:6] Set("SIP/2104-00000527", "SCOPSERV_DBPUT(default/2104/RepeatDial)=0114657672") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:7] Set("SIP/2104-00000527", "SCOPSERV_DBPUT(default/wrapup/2104/lastcall)=1347517404.1367") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:8] Set("SIP/2104-00000527", "GROUP(OUTGOING_DEFAULT)=2104") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:9] GotoIf("SIP/2104-00000527", "1?12") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Goto (macro-default-dial-cav-joh-002-000918,s,12)
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:12] Set("SIP/2104-00000527", "OUT_TENANT=default") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:13] Set("SIP/2104-00000527", "OUT_EXTEN=27114657672") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:14] Set("SIP/2104-00000527", "OUT_EXTEN_FULL=0114657672") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:15] Set("SIP/2104-00000527", "OUT_FORCECID=0") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:16] Set("SIP/2104-00000527", "OUT_LOOKUPAGI=0") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:17] Set("SIP/2104-00000527", "OUT_LOOKUPCUSTOM=0") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:18] Set("SIP/2104-00000527", "OUT_CIDNUM=") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:19] Set("SIP/2104-00000527", "OUT_CIDNAME=") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:20] Goto("SIP/2104-00000527", "50") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Goto (macro-default-dial-cav-joh-002-000918,s,50)
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:50] GotoIf("SIP/2104-00000527", "1?52") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Goto (macro-default-dial-cav-joh-002-000918,s,52)
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:52] GotoIf("SIP/2104-00000527", "0?56") in new stack
[2012-09-13 08:23:31] VERBOSE[695] pbx.c: [2012-09-13 08:23:31]     -- Executing [s@macro-default-dial-cav-joh-002-000918:53] AGI("SIP/2104-00000527", "agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING") in new stack
[2012-09-13 08:23:31] WARNING[23923] chan_sip.c: Autodestruct on dialog '13634fb2-3b4b0873-da34b50@192.168.2.148' with owner SIP/2106-00000509 in place (Method: BYE). Rescheduling destruction for 10000 ms
[2012-09-13 08:23:32] VERBOSE[382] file.c: [2012-09-13 08:23:32]     -- <SIP/2113-00000520> Playing 'auth-thankyou.ulaw' (language 'en')
[2012-09-13 08:23:32] WARNING[23923] chan_sip.c: Autodestruct on dialog '7c09cf12-d2fd591-c462e10@192.168.2.68' with owner SIP/2053-000002b5 in place (Method: BYE). Rescheduling destruction for 10000 ms
[2012-09-13 08:23:32] VERBOSE[753] res_agi.c: [2012-09-13 08:23:32]  agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:32] VERBOSE[382] pbx.c: [2012-09-13 08:23:32]     -- Executing [s@macro-default-dial-cav-joh-002-000918:78] ResetCDR("SIP/2113-00000520", "") in new stack
[2012-09-13 08:23:32] VERBOSE[382] pbx.c: [2012-09-13 08:23:32]     -- Executing [s@macro-default-dial-cav-joh-002-000918:79] GotoIf("SIP/2113-00000520", "1?81") in new stack
[2012-09-13 08:23:32] VERBOSE[382] pbx.c: [2012-09-13 08:23:32]     -- Goto (macro-default-dial-cav-joh-002-000918,s,81)
[2012-09-13 08:23:32] VERBOSE[382] pbx.c: [2012-09-13 08:23:32]     -- Executing [s@macro-default-dial-cav-joh-002-000918:81] ExecIf("SIP/2113-00000520", "1?Dial(SIP/27736928886@Cav-Joh-002,60,gF(all-hangup,s,1)):Dial(SIP/27736928886@Cav-Joh-002,60,gF(all-hangup,s,1)grM(all-call-screening^2113^macro-default-dial-cav-joh-002-000918^s^81))") in new stack
[2012-09-13 08:23:32] VERBOSE[382] netsock2.c: [2012-09-13 08:23:32]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:32] VERBOSE[382] netsock2.c: [2012-09-13 08:23:32]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:32] VERBOSE[382] app_dial.c: [2012-09-13 08:23:32]     -- Called SIP/27736928886@Cav-Joh-002
[2012-09-13 08:23:32] VERBOSE[770] app_dial.c: [2012-09-13 08:23:32]     -- SIP/2005-0000052e answered Local/2005@default-agent-00000018;2
[2012-09-13 08:23:32] VERBOSE[767] app_queue.c: [2012-09-13 08:23:32]     -- Local/2005@default-agent-00000018;1 answered SIP/Cav-Joh-002-0000052d
[2012-09-13 08:23:32] VERBOSE[767] res_musiconhold.c: [2012-09-13 08:23:32]     -- Stopped music on hold on SIP/Cav-Joh-002-0000052d
[2012-09-13 08:23:32] VERBOSE[781] app_mixmonitor.c: [2012-09-13 08:23:32]   == Begin MixMonitor Recording SIP/Cav-Joh-002-0000052d
[2012-09-13 08:23:33] VERBOSE[382] app_dial.c: [2012-09-13 08:23:33]     -- SIP/Cav-Joh-002-00000530 is making progress passing it to SIP/2113-00000520
[2012-09-13 08:23:33] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:33]   == Using SIP RTP TOS bits 184
[2012-09-13 08:23:33] VERBOSE[23923] netsock2.c: [2012-09-13 08:23:33]   == Using SIP RTP CoS mark 5
[2012-09-13 08:23:33] VERBOSE[783] pbx.c: [2012-09-13 08:23:33]     -- Executing [0833640658@default-default:1] Macro("SIP/2091-00000531", "default-dial-cav-joh-002-000918") in new stack
[2012-09-13 08:23:33] VERBOSE[783] pbx.c: [2012-09-13 08:23:33]     -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2091-00000531", "agi://127.0.0.1:4573/extension") in new stack
[2012-09-13 08:23:33] VERBOSE[382] app_dial.c: [2012-09-13 08:23:33]     -- SIP/Cav-Joh-002-00000530 is ringing
[2012-09-13 08:23:33] VERBOSE[380] app_dial.c: [2012-09-13 08:23:33]     -- SIP/Cav-Joh-002-0000052c is ringing
[2012-09-13 08:23:33] VERBOSE[682] res_agi.c: [2012-09-13 08:23:33]  agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2025
[2012-09-13 08:23:33] VERBOSE[380] app_dial.c: [2012-09-13 08:23:33]     -- SIP/Cav-Joh-002-0000052c is making progress passing it to SIP/2105-0000051f
[2012-09-13 08:23:33] VERBOSE[682] res_agi.c: [2012-09-13 08:23:33]     -- <SIP/2025-00000526>AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0
[2012-09-13 08:23:33] VERBOSE[682] pbx.c: [2012-09-13 08:23:33]     -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2025-00000526", "TOUCH_MONITOR=2025_1347517403.1366") in new stack
[2012-09-13 08:23:33] VERBOSE[682] pbx.c: [2012-09-13 08:23:33]     -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2025-00000526", "TOUCH_MIXMONITOR=2025_1347517403.1366") in new stack
[2012-09-13 08:23:33] VERBOSE[682] pbx.c: [2012-09-13 08:23:33]     -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2025-00000526", "0?60") in new stack
[2012-09-13 08:23:33] VERBOSE[682] pbx.c: [2012-09-13 08:23:33]     -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2025-00000526", "agi://127.0.0.1:4573/monitortag") in new stack
[2012-09-13 08:23:34] VERBOSE[390] app_dial.c: [2012-09-13 08:23:34]     -- SIP/Cav-Joh-002-0000052f is making progress passing it to SIP/2045-00000521
[2012-09-13 08:23:34] VERBOSE[382] app_dial.c: [2012-09-13 08:23:34]     -- SIP/Cav-Joh-002-00000530 answered SIP/2113-00000520
[2012-09-13 08:23:34] VERBOSE[756] res_agi.c: [2012-09-13 08:23:34]  agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!!
[2012-09-13 08:23:34] VERBOSE[709] res_agi.c: [2012-09-13 08:23:34]  agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!!
[2012-09-13 08:23:34] VERBOSE[709] res_agi.c: [2012-09-13 08:23:34]     -- <SIP/2023-00000528>AGI Script agi://127.0.0.1:4573/extension completed, returning 0
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:2] Set("SIP/2023-00000528", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:3] GotoIf("SIP/2023-00000528", "0?6000:4") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Goto (macro-default-dial-cav-joh-002-000918,s,4)
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:4] Set("SIP/2023-00000528", "TOUCH_MONITOR=1347517405.1368") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:5] Set("SIP/2023-00000528", "TOUCH_MIXMONITOR=1347517405.1368") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:6] Set("SIP/2023-00000528", "SCOPSERV_DBPUT(default/2023/RepeatDial)=0789942054") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:7] Set("SIP/2023-00000528", "SCOPSERV_DBPUT(default/wrapup/2023/lastcall)=1347517405.1368") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:8] Set("SIP/2023-00000528", "GROUP(OUTGOING_DEFAULT)=2023") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:9] GotoIf("SIP/2023-00000528", "1?12") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Goto (macro-default-dial-cav-joh-002-000918,s,12)
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:12] Set("SIP/2023-00000528", "OUT_TENANT=default") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:13] Set("SIP/2023-00000528", "OUT_EXTEN=27789942054") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:14] Set("SIP/2023-00000528", "OUT_EXTEN_FULL=0789942054") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:15] Set("SIP/2023-00000528", "OUT_FORCECID=0") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:16] Set("SIP/2023-00000528", "OUT_LOOKUPAGI=0") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:17] Set("SIP/2023-00000528", "OUT_LOOKUPCUSTOM=0") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:18] Set("SIP/2023-00000528", "OUT_CIDNUM=") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:19] Set("SIP/2023-00000528", "OUT_CIDNAME=") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:20] Goto("SIP/2023-00000528", "50") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Goto (macro-default-dial-cav-joh-002-000918,s,50)
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:50] GotoIf("SIP/2023-00000528", "1?52") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Goto (macro-default-dial-cav-joh-002-000918,s,52)
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:52] GotoIf("SIP/2023-00000528", "0?56") in new stack
[2012-09-13 08:23:34] VERBOSE[709] pbx.c: [2012-09-13 08:23:34]     -- Executing [s@macro-default-dial-cav-joh-002-000918:53] AGI("SIP/2023-00000528", "agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING") in new stack
[2012-09-13 08:23:34] VERBOSE[390] app_dial.c: [2012-09-13 08:23:34]     -- SIP/Cav-Joh-002-0000052f is ringing
[2012-09-13 08:23:34] WARNING[23923] chan_sip.c: Autodestruct on dialog '5573c4333c63b3953fc0b03900e49309@172.20.8.114:5060' with owner SIP/Cav-Joh-002-000002be in place (Method: BYE). Rescheduling destruction for 10000 ms
[2012-09-13 08:23:36] VERBOSE[720] res_agi.c: [2012-09-13 08:23:36]  agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!!
[2012-09-13 08:23:36] VERBOSE[720] res_agi.c: [2012-09-13 08:23:36]     -- <SIP/2119-00000529>AGI Script agi://127.0.0.1:4573/extension completed, returning 0
[2012-09-13 08:23:36] VERBOSE[720] pbx.c: [2012-09-13 08:23:36]     -- Executing [s@macro-default-dial-cav-joh-002-000918:2] Set("SIP/2119-00000529", "TRUNK_DISABLE=") in new stack
[2012-09-13 08:23:36] VERBOSE[720] pbx.c: [2012-09-13 08:23:36]     -- Executing [s@macro-default-dial-cav-joh-002-000918:3] GotoIf("SIP/2119-00000529", "0?6000:4") in new stack
[2012-09-13 08:23:36] VERBOSE[720] pbx.c: [2012-09-13 08:23:36]     -- Goto (macro-default-dial-cav-joh-002-000918,s,4)
[2012-09-13 08:23:36] VERBOSE[720] pbx.c: [2012-09-13 08:23:36]     -- Executing [s@macro-default-dial-cav-joh-002-000918:4] Set("SIP/2119-00000529", "TOUCH_MONITOR=1347517406.1369") in new stack
[2012-09-13 08:23:36] VERBOSE[720] pbx.c: [2012-09-13 08:23:36]     -- Executing [s@macro-default-dial-cav-joh-002-000918:5] Set("SIP/2119-00000529", "TOUCH_MIXMONITOR=1347517406.1369") in new stack
[2012-09-13 08:23:36] VERBOSE[720] pbx.c: [2012-09-13 08:23:36]     -- Executing [s@macro-default-dial-cav-joh-002-000918:6] Set("SIP/2119-00000529", "SCOPSERV_DBPUT(default/2119/RepeatDial)=0723056864") in new stack
[2012-09-13 08:23:36] VERBOSE[720] pbx.c: [2012-09-13 08:23:36]     -- Executing [s@macro-default-dial-cav-joh-002-000918:7] Set("SIP/2119-00000529", "SCOPSERV_DBPUT(default/wrapup/2119/lastcall)=1347517406.1369") in new stack