AGI("SIP/2068-00000865", "agi://127.0.0.1:4573/extension") in new stack [2012-09-13 10:56:52] VERBOSE[2823] res_agi.c: [2012-09-13 10:56:52] agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2126 [2012-09-13 10:56:52] VERBOSE[2823] res_agi.c: [2012-09-13 10:56:52] -- AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0 [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2126-00000851", "CALLFILENAME=2126_1347526596.2219") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2126-00000851", "2126_1347526596.2219.WAV,ab") in new stack [2012-09-13 10:56:52] VERBOSE[3028] app_mixmonitor.c: [2012-09-13 10:56:52] == Begin MixMonitor Recording SIP/2126-00000851 [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2126-00000851", "TRUNK_DISABLE=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2126-00000851", "0?100:62") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,62) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2126-00000851", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2126-00000851", "CALLFILENAME=1347526596.2219") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2126-00000851", "1?65:66") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,65) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2126-00000851", "1347526596.2219.WAV,ab") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2126-00000851", "OUT_TRUNK_CIDNUM=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2126-00000851", "OUT_TRUNK_CIDNAME=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2126-00000851", "OUT_TRUNK_FORCECID=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2126-00000851", "all-outgoing-checkcid,s,1") in new stack [2012-09-13 10:56:52] VERBOSE[3029] app_mixmonitor.c: [2012-09-13 10:56:52] == Begin MixMonitor Recording SIP/2126-00000851 [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2126-00000851", "ext_cidname=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2126-00000851", "1?50") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,50) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2126-00000851", "ext_cidnum=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2126-00000851", "ext_cidpres=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2126-00000851", "1?54") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,54) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2126-00000851", "1?56") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,56) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2126-00000851", "1?59") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,59) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2126-00000851", "1?61") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,61) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2126-00000851", "agentid=6066") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2126-00000851", "0?69") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2126-00000851", "agent_cidname=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2126-00000851", "agent_cidnum=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2126-00000851", "1?67") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,67) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2126-00000851", "1?69") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,69) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2126-00000851", "ext_override=") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2126-00000851", "1?100") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,100) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2126-00000851", "1?102") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,102) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2126-00000851", "1?104") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,104) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2126-00000851", "0?105:150") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,150) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2126-00000851", "0?151:175") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,175) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2126-00000851", "0?176:200") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,200) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2126-00000851", "1?202") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,202) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2126-00000851", "1?204") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,204) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2126-00000851", "") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2126-00000851", "0?75:71") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,71) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2126-00000851", "0?72:74") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,74) [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2126-00000851", "CALLSCREEN=NO") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2126-00000851", "0?79") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2126-00000851", "0?79") in new stack [2012-09-13 10:56:52] VERBOSE[2823] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2126-00000851", "/pw_default_credit_clear,da,,agent-pass") in new stack [2012-09-13 10:56:52] WARNING[1993] chan_sip.c: Autodestruct on dialog '149fb0d3-b3048aec-56db1321@192.168.2.69' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:52] VERBOSE[2823] file.c: [2012-09-13 10:56:52] -- Playing 'agent-pass.ulaw' (language 'en') [2012-09-13 10:56:52] VERBOSE[2783] res_agi.c: [2012-09-13 10:56:52] agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2118 [2012-09-13 10:56:52] VERBOSE[2783] res_agi.c: [2012-09-13 10:56:52] -- AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0 [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2118-0000084d", "CALLFILENAME=2118_1347526591.2215") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2118-0000084d", "2118_1347526591.2215.WAV,ab") in new stack [2012-09-13 10:56:52] VERBOSE[3030] app_mixmonitor.c: [2012-09-13 10:56:52] == Begin MixMonitor Recording SIP/2118-0000084d [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2118-0000084d", "TRUNK_DISABLE=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2118-0000084d", "0?100:62") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,62) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2118-0000084d", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2118-0000084d", "CALLFILENAME=1347526591.2215") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2118-0000084d", "1?65:66") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,65) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2118-0000084d", "1347526591.2215.WAV,ab") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2118-0000084d", "OUT_TRUNK_CIDNUM=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2118-0000084d", "OUT_TRUNK_CIDNAME=") in new stack [2012-09-13 10:56:52] VERBOSE[3031] app_mixmonitor.c: [2012-09-13 10:56:52] == Begin MixMonitor Recording SIP/2118-0000084d [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2118-0000084d", "OUT_TRUNK_FORCECID=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2118-0000084d", "all-outgoing-checkcid,s,1") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2118-0000084d", "ext_cidname=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2118-0000084d", "1?50") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,50) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2118-0000084d", "ext_cidnum=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2118-0000084d", "ext_cidpres=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2118-0000084d", "1?54") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,54) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2118-0000084d", "1?56") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,56) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2118-0000084d", "1?59") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,59) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2118-0000084d", "1?61") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,61) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2118-0000084d", "agentid=6094") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2118-0000084d", "0?69") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2118-0000084d", "agent_cidname=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2118-0000084d", "agent_cidnum=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2118-0000084d", "1?67") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,67) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2118-0000084d", "1?69") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,69) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2118-0000084d", "ext_override=") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2118-0000084d", "1?100") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,100) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2118-0000084d", "1?102") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,102) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2118-0000084d", "1?104") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,104) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2118-0000084d", "0?105:150") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,150) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2118-0000084d", "0?151:175") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,175) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2118-0000084d", "0?176:200") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,200) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2118-0000084d", "1?202") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,202) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2118-0000084d", "1?204") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (all-outgoing-checkcid,s,204) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2118-0000084d", "") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2118-0000084d", "0?75:71") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,71) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2118-0000084d", "0?72:74") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Goto (macro-default-dial-cav-joh-002-000918,s,74) [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2118-0000084d", "CALLSCREEN=NO") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2118-0000084d", "0?79") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2118-0000084d", "0?79") in new stack [2012-09-13 10:56:52] VERBOSE[2783] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2118-0000084d", "/pw_default_credit_clear,da,,agent-pass") in new stack [2012-09-13 10:56:52] WARNING[1993] chan_sip.c: Autodestruct on dialog '7bca7d4e0b9dd55c3b008f1334ac70bf@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:52] VERBOSE[2783] file.c: [2012-09-13 10:56:52] -- Playing 'agent-pass.ulaw' (language 'en') [2012-09-13 10:56:52] VERBOSE[2015] res_agi.c: [2012-09-13 10:56:52] agi://127.0.0.1:4573/dial: Variable 'ARG12' result is vm [2012-09-13 10:56:52] VERBOSE[1389] res_musiconhold.c: [2012-09-13 10:56:52] -- Stopped music on hold on SIP/Cav-Joh-002-000007e4 [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:16] NoOp("SIP/Cav-Joh-002-000007e4", "TIMEOUT") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:17] GotoIf("SIP/Cav-Joh-002-000007e4", "0?18:20") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Goto (default-application-acd-prodepartment,s,20) [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:20] GotoIf("SIP/Cav-Joh-002-000007e4", "0?21:23") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Goto (default-application-acd-prodepartment,s,23) [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:23] GotoIf("SIP/Cav-Joh-002-000007e4", "0?24:26") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Goto (default-application-acd-prodepartment,s,26) [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:26] GotoIf("SIP/Cav-Joh-002-000007e4", "0?1000") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:27] GotoIf("SIP/Cav-Joh-002-000007e4", "0?1000") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:28] GotoIf("SIP/Cav-Joh-002-000007e4", "1?1000") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Goto (default-application-acd-prodepartment,s,1000) [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:1000] Set("SIP/Cav-Joh-002-000007e4", "QUEUE_PRIO=0") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:1001] Set("SIP/Cav-Joh-002-000007e4", "QUEUE_RULE=") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:1002] Gosub("SIP/Cav-Joh-002-000007e4", "default-application-acd-prodepartment,s,1") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-000007e4", "HANGUPSIDE=CALLEE") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-000007e4", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-000007e4", ""=== START QUEUE (default-prodepartment) ==="") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-000007e4", "__QUEUENAME=default-prodepartment") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-000007e4", "1?8") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Goto (default-application-acd-prodepartment,s,8) [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-000007e4", "MONITOR_FILENAME=1347526502.2110") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-000007e4", "TIMEOUT(digit)=1") in new stack [2012-09-13 10:56:52] VERBOSE[1389] func_timeout.c: [2012-09-13 10:56:52] -- Digit timeout set to 1.000 [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-000007e4", "TIMEOUT(response)=1") in new stack [2012-09-13 10:56:52] VERBOSE[1389] func_timeout.c: [2012-09-13 10:56:52] -- Response timeout set to 1.000 [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-000007e4", "__ACD_TO_OUTGOING=1") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-000007e4", "CHANNEL(musicclass)=default") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-000007e4", "__ALLOW_TRANSFER=t") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-000007e4", "CHANNEL(language)=en") in new stack [2012-09-13 10:56:52] VERBOSE[1389] pbx.c: [2012-09-13 10:56:52] -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-000007e4", "default-prodepartment,t,,,10,,,,,,") in new stack [2012-09-13 10:56:52] VERBOSE[1389] res_musiconhold.c: [2012-09-13 10:56:52] -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-000007e4' [2012-09-13 10:56:52] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:52] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:52] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:52] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:52] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:52] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:52] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:52] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:52] VERBOSE[3036] pbx.c: [2012-09-13 10:56:52] -- Executing [0737214670@default-default:1] Macro("SIP/2037-00000866", "default-dial-cav-joh-002-000918") in new stack [2012-09-13 10:56:52] VERBOSE[3036] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2037-00000866", "agi://127.0.0.1:4573/extension") in new stack [2012-09-13 10:56:52] VERBOSE[3037] pbx.c: [2012-09-13 10:56:52] -- Executing [0780789309@default-default:1] Macro("SIP/2135-00000867", "default-dial-cav-joh-002-000918") in new stack [2012-09-13 10:56:52] VERBOSE[3037] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2135-00000867", "agi://127.0.0.1:4573/extension") in new stack [2012-09-13 10:56:52] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:52] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:52] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:52] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:52] VERBOSE[3040] pbx.c: [2012-09-13 10:56:52] -- Executing [0741851109@default-default:1] Macro("SIP/2129-00000868", "default-dial-cav-joh-002-000918") in new stack [2012-09-13 10:56:52] VERBOSE[3040] pbx.c: [2012-09-13 10:56:52] -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2129-00000868", "agi://127.0.0.1:4573/extension") in new stack [2012-09-13 10:56:52] VERBOSE[2370] app_dial.c: [2012-09-13 10:56:52] -- SIP/Cav-Joh-002-0000085a answered SIP/2052-00000834 [2012-09-13 10:56:53] VERBOSE[2983] res_agi.c: [2012-09-13 10:56:53] agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!! [2012-09-13 10:56:53] VERBOSE[2825] res_agi.c: [2012-09-13 10:56:53] agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2102 [2012-09-13 10:56:53] VERBOSE[2983] res_agi.c: [2012-09-13 10:56:53] -- AGI Script agi://127.0.0.1:4573/extension completed, returning 0 [2012-09-13 10:56:53] VERBOSE[2825] res_agi.c: [2012-09-13 10:56:53] -- AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0 [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2102-00000852", "CALLFILENAME=2102_1347526596.2220") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2102-00000852", "2102_1347526596.2220.WAV,ab") in new stack [2012-09-13 10:56:53] VERBOSE[3042] app_mixmonitor.c: [2012-09-13 10:56:53] == Begin MixMonitor Recording SIP/2102-00000852 [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:2] Set("SIP/2108-00000860", "TRUNK_DISABLE=") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2102-00000852", "TRUNK_DISABLE=") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2102-00000852", "0?100:62") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,62) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2102-00000852", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2102-00000852", "CALLFILENAME=1347526596.2220") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2102-00000852", "1?65:66") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,65) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2102-00000852", "1347526596.2220.WAV,ab") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2102-00000852", "OUT_TRUNK_CIDNUM=") in new stack [2012-09-13 10:56:53] VERBOSE[3043] app_mixmonitor.c: [2012-09-13 10:56:53] == Begin MixMonitor Recording SIP/2102-00000852 [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2102-00000852", "OUT_TRUNK_CIDNAME=") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:3] GotoIf("SIP/2108-00000860", "0?6000:4") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2102-00000852", "OUT_TRUNK_FORCECID=") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,4) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2102-00000852", "all-outgoing-checkcid,s,1") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:4] Set("SIP/2108-00000860", "TOUCH_MONITOR=1347526605.2234") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:5] Set("SIP/2108-00000860", "TOUCH_MIXMONITOR=1347526605.2234") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:6] Set("SIP/2108-00000860", "SCOPSERV_DBPUT(default/2108/RepeatDial)=0715614973") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2102-00000852", "ext_cidname=") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2102-00000852", "1?50") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,50) [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:7] Set("SIP/2108-00000860", "SCOPSERV_DBPUT(default/wrapup/2108/lastcall)=1347526605.2234") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2102-00000852", "ext_cidnum=") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:8] Set("SIP/2108-00000860", "GROUP(OUTGOING_DEFAULT)=2108") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:9] GotoIf("SIP/2108-00000860", "1?12") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,12) [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:12] Set("SIP/2108-00000860", "OUT_TENANT=default") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:13] Set("SIP/2108-00000860", "OUT_EXTEN=27715614973") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:14] Set("SIP/2108-00000860", "OUT_EXTEN_FULL=0715614973") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:15] Set("SIP/2108-00000860", "OUT_FORCECID=0") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:16] Set("SIP/2108-00000860", "OUT_LOOKUPAGI=0") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:17] Set("SIP/2108-00000860", "OUT_LOOKUPCUSTOM=0") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:18] Set("SIP/2108-00000860", "OUT_CIDNUM=") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:19] Set("SIP/2108-00000860", "OUT_CIDNAME=") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:20] Goto("SIP/2108-00000860", "50") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,50) [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:50] GotoIf("SIP/2108-00000860", "1?52") in new stack [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,52) [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:52] GotoIf("SIP/2108-00000860", "0?56") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2102-00000852", "ext_cidpres=") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2102-00000852", "1?54") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,54) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2102-00000852", "1?56") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,56) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2102-00000852", "1?59") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,59) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2102-00000852", "1?61") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,61) [2012-09-13 10:56:53] VERBOSE[2983] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:53] AGI("SIP/2108-00000860", "agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2102-00000852", "agentid=5105") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2102-00000852", "0?69") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2102-00000852", "agent_cidname=") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2102-00000852", "agent_cidnum=") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2102-00000852", "1?67") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,67) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2102-00000852", "1?69") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,69) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2102-00000852", "ext_override=") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2102-00000852", "1?100") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,100) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2102-00000852", "1?102") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,102) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2102-00000852", "1?104") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,104) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2102-00000852", "0?105:150") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,150) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2102-00000852", "0?151:175") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,175) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2102-00000852", "0?176:200") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,200) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2102-00000852", "1?202") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,202) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2102-00000852", "1?204") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (all-outgoing-checkcid,s,204) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2102-00000852", "") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2102-00000852", "0?75:71") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,71) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2102-00000852", "0?72:74") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Goto (macro-default-dial-cav-joh-002-000918,s,74) [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2102-00000852", "CALLSCREEN=NO") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2102-00000852", "0?79") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2102-00000852", "0?79") in new stack [2012-09-13 10:56:53] VERBOSE[2825] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2102-00000852", "/pw_default_credit_clear,da,,agent-pass") in new stack [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog '4749fae4-ce4cbd63-6307d1e2@192.168.2.68' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog '4eb8c387-d217a860-bcde413d@192.168.2.128' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] VERBOSE[2825] file.c: [2012-09-13 10:56:53] -- Playing 'agent-pass.ulaw' (language 'en') [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog 'e04fb61f-c229253a-e669af51@192.168.2.89' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] VERBOSE[2846] res_agi.c: [2012-09-13 10:56:53] agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2101 [2012-09-13 10:56:53] VERBOSE[2846] res_agi.c: [2012-09-13 10:56:53] -- AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0 [2012-09-13 10:56:53] VERBOSE[2846] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2101-00000853", "TOUCH_MONITOR=2101_1347526597.2221") in new stack [2012-09-13 10:56:53] VERBOSE[2846] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2101-00000853", "TOUCH_MIXMONITOR=2101_1347526597.2221") in new stack [2012-09-13 10:56:53] VERBOSE[2846] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2101-00000853", "0?60") in new stack [2012-09-13 10:56:53] VERBOSE[2846] pbx.c: [2012-09-13 10:56:53] -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2101-00000853", "agi://127.0.0.1:4573/monitortag") in new stack [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog '5847b3de-86bf3847-cc650eb0@192.168.2.74' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] VERBOSE[32638] res_musiconhold.c: [2012-09-13 10:56:53] -- Stopped music on hold on SIP/Cav-Joh-002-0000079b [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:16] NoOp("SIP/Cav-Joh-002-0000079b", "TIMEOUT") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:17] GotoIf("SIP/Cav-Joh-002-0000079b", "0?18:20") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Goto (default-application-acd-prodepartment,s,20) [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:20] GotoIf("SIP/Cav-Joh-002-0000079b", "0?21:23") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Goto (default-application-acd-prodepartment,s,23) [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:23] GotoIf("SIP/Cav-Joh-002-0000079b", "0?24:26") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Goto (default-application-acd-prodepartment,s,26) [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:26] GotoIf("SIP/Cav-Joh-002-0000079b", "0?1000") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:27] GotoIf("SIP/Cav-Joh-002-0000079b", "0?1000") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:28] GotoIf("SIP/Cav-Joh-002-0000079b", "1?1000") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Goto (default-application-acd-prodepartment,s,1000) [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:1000] Set("SIP/Cav-Joh-002-0000079b", "QUEUE_PRIO=0") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:1001] Set("SIP/Cav-Joh-002-0000079b", "QUEUE_RULE=") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:1002] Gosub("SIP/Cav-Joh-002-0000079b", "default-application-acd-prodepartment,s,1") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-0000079b", "HANGUPSIDE=CALLEE") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-0000079b", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-0000079b", ""=== START QUEUE (default-prodepartment) ==="") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-0000079b", "__QUEUENAME=default-prodepartment") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-0000079b", "1?8") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Goto (default-application-acd-prodepartment,s,8) [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-0000079b", "MONITOR_FILENAME=1347526431.2037") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-0000079b", "TIMEOUT(digit)=1") in new stack [2012-09-13 10:56:53] VERBOSE[32638] func_timeout.c: [2012-09-13 10:56:53] -- Digit timeout set to 1.000 [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-0000079b", "TIMEOUT(response)=1") in new stack [2012-09-13 10:56:53] VERBOSE[32638] func_timeout.c: [2012-09-13 10:56:53] -- Response timeout set to 1.000 [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-0000079b", "__ACD_TO_OUTGOING=1") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-0000079b", "CHANNEL(musicclass)=default") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-0000079b", "__ALLOW_TRANSFER=t") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-0000079b", "CHANNEL(language)=en") in new stack [2012-09-13 10:56:53] VERBOSE[32638] pbx.c: [2012-09-13 10:56:53] -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-0000079b", "default-prodepartment,t,,,10,,,,,,") in new stack [2012-09-13 10:56:53] VERBOSE[32638] res_musiconhold.c: [2012-09-13 10:56:53] -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-0000079b' [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog '2c234cee117838a80850b81c4cef9aa3@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog 'c887a3b6-5848f5a7-98f53788@192.168.2.175' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog '088c0f6242660fbb05428a93673b7e44@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog '4be66cd-c263a86a-4dd2017b@192.168.2.172' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] WARNING[1993] chan_sip.c: Autodestruct on dialog '7b47c3101fbfdaee4333f90d62080af7@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:53] VERBOSE[1429] app_mixmonitor.c: [2012-09-13 10:56:53] == End MixMonitor Recording SIP/2111-000007de [2012-09-13 10:56:53] VERBOSE[1428] app_mixmonitor.c: [2012-09-13 10:56:53] == End MixMonitor Recording SIP/2111-000007de [2012-09-13 10:56:54] WARNING[1993] chan_sip.c: Autodestruct on dialog '9128ff05-67e7b42e-a128d067@192.168.2.57' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:54] WARNING[1993] chan_sip.c: Autodestruct on dialog '1a6c7d8614293c062e09ac40043973df@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:54] WARNING[1993] chan_sip.c: Autodestruct on dialog '5d266167386735d070effe547a5e20cf@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:54] VERBOSE[2966] res_agi.c: [2012-09-13 10:56:54] agi://127.0.0.1:4573/extension: Variable 'CHECK_HOTDESK' result is not defined!!! [2012-09-13 10:56:54] VERBOSE[2949] res_agi.c: [2012-09-13 10:56:54] agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2025 [2012-09-13 10:56:54] VERBOSE[2966] res_agi.c: [2012-09-13 10:56:54] -- AGI Script agi://127.0.0.1:4573/extension completed, returning 4 [2012-09-13 10:56:54] VERBOSE[2966] app_macro.c: [2012-09-13 10:56:54] == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 1) exited non-zero on 'SIP/2138-0000085e' in macro 'default-dial-cav-joh-002-000918' [2012-09-13 10:56:54] VERBOSE[2966] pbx.c: [2012-09-13 10:56:54] == Spawn extension (default-default, 0825632848, 1) exited non-zero on 'SIP/2138-0000085e' [2012-09-13 10:56:54] VERBOSE[2949] res_agi.c: [2012-09-13 10:56:54] -- AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0 [2012-09-13 10:56:54] VERBOSE[2949] pbx.c: [2012-09-13 10:56:54] -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2025-0000085b", "TOUCH_MONITOR=2025_1347526602.2229") in new stack [2012-09-13 10:56:54] VERBOSE[2949] pbx.c: [2012-09-13 10:56:54] -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2025-0000085b", "TOUCH_MIXMONITOR=2025_1347526602.2229") in new stack [2012-09-13 10:56:54] VERBOSE[2949] pbx.c: [2012-09-13 10:56:54] -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2025-0000085b", "0?60") in new stack [2012-09-13 10:56:54] VERBOSE[2949] pbx.c: [2012-09-13 10:56:54] -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2025-0000085b", "agi://127.0.0.1:4573/monitortag") in new stack [2012-09-13 10:56:54] WARNING[1993] chan_sip.c: Autodestruct on dialog 'b0466834-7785a0eb-2a9e5d02@192.168.2.134' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:54] WARNING[1993] chan_sip.c: Autodestruct on dialog 'd3f676c5-ea065918-7bea3683@192.168.2.179' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:54] VERBOSE[2485] file.c: [2012-09-13 10:56:54] -- Playing 'auth-thankyou.ulaw' (language 'en') [2012-09-13 10:56:54] VERBOSE[2245] app_macro.c: [2012-09-13 10:56:54] == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 81) exited non-zero on 'SIP/2070-00000831' in macro 'default-dial-cav-joh-002-000918' [2012-09-13 10:56:54] VERBOSE[2245] pbx.c: [2012-09-13 10:56:54] == Spawn extension (default-default, 0797908442, 1) exited non-zero on 'SIP/2070-00000831' [2012-09-13 10:56:54] WARNING[1993] chan_sip.c: Autodestruct on dialog 'ae757325-d7eba8d8-e9e72787@192.168.2.115' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:54] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:54] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:54] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:54] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:54] VERBOSE[3054] pbx.c: [2012-09-13 10:56:54] -- Executing [0784944246@default-default:1] Macro("SIP/2024-00000869", "default-dial-cav-joh-002-000918") in new stack [2012-09-13 10:56:54] VERBOSE[3054] pbx.c: [2012-09-13 10:56:54] -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2024-00000869", "agi://127.0.0.1:4573/extension") in new stack [2012-09-13 10:56:54] VERBOSE[2795] file.c: [2012-09-13 10:56:54] -- Playing 'auth-thankyou.ulaw' (language 'en') [2012-09-13 10:56:55] WARNING[1993] chan_sip.c: Autodestruct on dialog '31d14f8-3cfe9453-323b2b56@192.168.2.53' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:55] VERBOSE[32665] res_musiconhold.c: [2012-09-13 10:56:55] -- Stopped music on hold on SIP/Cav-Joh-002-0000079d [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:16] NoOp("SIP/Cav-Joh-002-0000079d", "TIMEOUT") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:17] GotoIf("SIP/Cav-Joh-002-0000079d", "0?18:20") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Goto (default-application-acd-prodepartment,s,20) [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:20] GotoIf("SIP/Cav-Joh-002-0000079d", "0?21:23") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Goto (default-application-acd-prodepartment,s,23) [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:23] GotoIf("SIP/Cav-Joh-002-0000079d", "0?24:26") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Goto (default-application-acd-prodepartment,s,26) [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:26] GotoIf("SIP/Cav-Joh-002-0000079d", "0?1000") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:27] GotoIf("SIP/Cav-Joh-002-0000079d", "0?1000") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:28] GotoIf("SIP/Cav-Joh-002-0000079d", "1?1000") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Goto (default-application-acd-prodepartment,s,1000) [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:1000] Set("SIP/Cav-Joh-002-0000079d", "QUEUE_PRIO=0") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:1001] Set("SIP/Cav-Joh-002-0000079d", "QUEUE_RULE=") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:1002] Gosub("SIP/Cav-Joh-002-0000079d", "default-application-acd-prodepartment,s,1") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-0000079d", "HANGUPSIDE=CALLEE") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-0000079d", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-0000079d", ""=== START QUEUE (default-prodepartment) ==="") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-0000079d", "__QUEUENAME=default-prodepartment") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-0000079d", "1?8") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Goto (default-application-acd-prodepartment,s,8) [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-0000079d", "MONITOR_FILENAME=1347526434.2039") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-0000079d", "TIMEOUT(digit)=1") in new stack [2012-09-13 10:56:55] VERBOSE[32665] func_timeout.c: [2012-09-13 10:56:55] -- Digit timeout set to 1.000 [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-0000079d", "TIMEOUT(response)=1") in new stack [2012-09-13 10:56:55] VERBOSE[32665] func_timeout.c: [2012-09-13 10:56:55] -- Response timeout set to 1.000 [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-0000079d", "__ACD_TO_OUTGOING=1") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-0000079d", "CHANNEL(musicclass)=default") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-0000079d", "__ALLOW_TRANSFER=t") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-0000079d", "CHANNEL(language)=en") in new stack [2012-09-13 10:56:55] VERBOSE[32665] pbx.c: [2012-09-13 10:56:55] -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-0000079d", "default-prodepartment,t,,,10,,,,,,") in new stack [2012-09-13 10:56:55] VERBOSE[32665] res_musiconhold.c: [2012-09-13 10:56:55] -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-0000079d' [2012-09-13 10:56:55] VERBOSE[2906] res_agi.c: [2012-09-13 10:56:55] agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2104 [2012-09-13 10:56:55] VERBOSE[2906] res_agi.c: [2012-09-13 10:56:55] -- AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0 [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2104-00000855", "CALLFILENAME=2104_1347526597.2223") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2104-00000855", "2104_1347526597.2223.WAV,ab") in new stack [2012-09-13 10:56:55] VERBOSE[3056] app_mixmonitor.c: [2012-09-13 10:56:55] == Begin MixMonitor Recording SIP/2104-00000855 [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2104-00000855", "TRUNK_DISABLE=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2104-00000855", "0?100:62") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (macro-default-dial-cav-joh-002-000918,s,62) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2104-00000855", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2104-00000855", "CALLFILENAME=1347526597.2223") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2104-00000855", "1?65:66") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (macro-default-dial-cav-joh-002-000918,s,65) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2104-00000855", "1347526597.2223.WAV,ab") in new stack [2012-09-13 10:56:55] VERBOSE[3057] app_mixmonitor.c: [2012-09-13 10:56:55] == Begin MixMonitor Recording SIP/2104-00000855 [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2104-00000855", "OUT_TRUNK_CIDNUM=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2104-00000855", "OUT_TRUNK_CIDNAME=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2104-00000855", "OUT_TRUNK_FORCECID=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2104-00000855", "all-outgoing-checkcid,s,1") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2104-00000855", "ext_cidname=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2104-00000855", "1?50") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,50) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2104-00000855", "ext_cidnum=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2104-00000855", "ext_cidpres=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2104-00000855", "1?54") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,54) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2104-00000855", "1?56") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,56) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2104-00000855", "1?59") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,59) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2104-00000855", "1?61") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,61) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2104-00000855", "agentid=5055") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2104-00000855", "0?69") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2104-00000855", "agent_cidname=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2104-00000855", "agent_cidnum=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2104-00000855", "1?67") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,67) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2104-00000855", "1?69") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,69) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2104-00000855", "ext_override=") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2104-00000855", "1?100") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,100) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2104-00000855", "1?102") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,102) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2104-00000855", "1?104") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,104) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2104-00000855", "0?105:150") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,150) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2104-00000855", "0?151:175") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,175) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2104-00000855", "0?176:200") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,200) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2104-00000855", "1?202") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,202) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2104-00000855", "1?204") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (all-outgoing-checkcid,s,204) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2104-00000855", "") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2104-00000855", "0?75:71") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (macro-default-dial-cav-joh-002-000918,s,71) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2104-00000855", "0?72:74") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Goto (macro-default-dial-cav-joh-002-000918,s,74) [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2104-00000855", "CALLSCREEN=NO") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2104-00000855", "0?79") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2104-00000855", "0?79") in new stack [2012-09-13 10:56:55] VERBOSE[2906] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2104-00000855", "/pw_default_credit_clear,da,,agent-pass") in new stack [2012-09-13 10:56:55] VERBOSE[2783] file.c: [2012-09-13 10:56:55] -- Playing 'auth-thankyou.ulaw' (language 'en') [2012-09-13 10:56:55] WARNING[1993] chan_sip.c: Autodestruct on dialog '14d5d580-18283a89-c93a4da6@192.168.2.171' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:55] VERBOSE[2906] file.c: [2012-09-13 10:56:55] -- Playing 'agent-pass.ulaw' (language 'en') [2012-09-13 10:56:55] VERBOSE[2688] file.c: [2012-09-13 10:56:55] -- Playing 'auth-thankyou.ulaw' (language 'en') [2012-09-13 10:56:55] VERBOSE[2686] app_dial.c: [2012-09-13 10:56:55] -- SIP/Cav-Joh-002-00000863 is ringing [2012-09-13 10:56:55] VERBOSE[2686] app_dial.c: [2012-09-13 10:56:55] -- SIP/Cav-Joh-002-00000863 is making progress passing it to SIP/2054-00000847 [2012-09-13 10:56:55] VERBOSE[2485] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:78] ResetCDR("SIP/2093-0000083f", "") in new stack [2012-09-13 10:56:55] VERBOSE[2485] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:79] GotoIf("SIP/2093-0000083f", "1?81") in new stack [2012-09-13 10:56:55] VERBOSE[2485] pbx.c: [2012-09-13 10:56:55] -- Goto (macro-default-dial-cav-joh-002-000918,s,81) [2012-09-13 10:56:55] VERBOSE[2485] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:81] ExecIf("SIP/2093-0000083f", "1?Dial(SIP/27719552993@Cav-Joh-002,60,gF(all-hangup,s,1)):Dial(SIP/27719552993@Cav-Joh-002,60,gF(all-hangup,s,1)grM(all-call-screening^2093^macro-default-dial-cav-joh-002-000918^s^81))") in new stack [2012-09-13 10:56:55] VERBOSE[2485] netsock2.c: [2012-09-13 10:56:55] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:55] VERBOSE[2485] netsock2.c: [2012-09-13 10:56:55] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:55] VERBOSE[2485] app_dial.c: [2012-09-13 10:56:55] -- Called SIP/27719552993@Cav-Joh-002 [2012-09-13 10:56:55] VERBOSE[2956] res_agi.c: [2012-09-13 10:56:55] agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2143 [2012-09-13 10:56:55] VERBOSE[2956] res_agi.c: [2012-09-13 10:56:55] -- AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0 [2012-09-13 10:56:55] VERBOSE[2956] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2143-0000085c", "TOUCH_MONITOR=2143_1347526603.2230") in new stack [2012-09-13 10:56:55] VERBOSE[2956] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2143-0000085c", "TOUCH_MIXMONITOR=2143_1347526603.2230") in new stack [2012-09-13 10:56:55] VERBOSE[2956] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2143-0000085c", "0?60") in new stack [2012-09-13 10:56:55] VERBOSE[2956] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2143-0000085c", "agi://127.0.0.1:4573/monitortag") in new stack [2012-09-13 10:56:55] VERBOSE[2795] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:78] ResetCDR("SIP/2026-0000084e", "") in new stack [2012-09-13 10:56:55] VERBOSE[2795] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:79] GotoIf("SIP/2026-0000084e", "1?81") in new stack [2012-09-13 10:56:55] VERBOSE[2795] pbx.c: [2012-09-13 10:56:55] -- Goto (macro-default-dial-cav-joh-002-000918,s,81) [2012-09-13 10:56:55] VERBOSE[2795] pbx.c: [2012-09-13 10:56:55] -- Executing [s@macro-default-dial-cav-joh-002-000918:81] ExecIf("SIP/2026-0000084e", "1?Dial(SIP/27823818280@Cav-Joh-002,60,gF(all-hangup,s,1)):Dial(SIP/27823818280@Cav-Joh-002,60,gF(all-hangup,s,1)grM(all-call-screening^2026^macro-default-dial-cav-joh-002-000918^s^81))") in new stack [2012-09-13 10:56:55] VERBOSE[2795] netsock2.c: [2012-09-13 10:56:55] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:55] VERBOSE[2795] netsock2.c: [2012-09-13 10:56:55] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:55] VERBOSE[2795] app_dial.c: [2012-09-13 10:56:55] -- Called SIP/27823818280@Cav-Joh-002 [2012-09-13 10:56:55] WARNING[1993] chan_sip.c: Autodestruct on dialog '624582686631eff75a61efcd3d9ab1ac@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:55] WARNING[2823] file.c: Failed to write frame [2012-09-13 10:56:55] VERBOSE[2823] file.c: [2012-09-13 10:56:55] -- Playing 'vm-goodbye.ulaw' (language 'en') [2012-09-13 10:56:55] VERBOSE[2823] app_macro.c: [2012-09-13 10:56:55] == Spawn extension (macro-default-dial-cav-joh-002-000918, s, 77) exited non-zero on 'SIP/2126-00000851' in macro 'default-dial-cav-joh-002-000918' [2012-09-13 10:56:55] VERBOSE[2823] pbx.c: [2012-09-13 10:56:55] == Spawn extension (default-default, 0825682773, 1) exited non-zero on 'SIP/2126-00000851' [2012-09-13 10:56:55] WARNING[1993] chan_sip.c: Autodestruct on dialog 'aaa6a2ba-927b5ed7-4c666ba0@192.168.2.136' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] VERBOSE[2958] res_agi.c: [2012-09-13 10:56:56] agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2090 [2012-09-13 10:56:56] VERBOSE[2958] res_agi.c: [2012-09-13 10:56:56] -- AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0 [2012-09-13 10:56:56] VERBOSE[2958] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2090-0000085d", "TOUCH_MONITOR=2090_1347526603.2231") in new stack [2012-09-13 10:56:56] VERBOSE[2958] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2090-0000085d", "TOUCH_MIXMONITOR=2090_1347526603.2231") in new stack [2012-09-13 10:56:56] VERBOSE[2958] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:56] GotoIf("SIP/2090-0000085d", "0?60") in new stack [2012-09-13 10:56:56] VERBOSE[2958] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:57] AGI("SIP/2090-0000085d", "agi://127.0.0.1:4573/monitortag") in new stack [2012-09-13 10:56:56] VERBOSE[2783] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:78] ResetCDR("SIP/2118-0000084d", "") in new stack [2012-09-13 10:56:56] VERBOSE[2783] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:79] GotoIf("SIP/2118-0000084d", "1?81") in new stack [2012-09-13 10:56:56] VERBOSE[2783] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,81) [2012-09-13 10:56:56] VERBOSE[2783] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:81] ExecIf("SIP/2118-0000084d", "1?Dial(SIP/27782115911@Cav-Joh-002,60,gF(all-hangup,s,1)):Dial(SIP/27782115911@Cav-Joh-002,60,gF(all-hangup,s,1)grM(all-call-screening^2118^macro-default-dial-cav-joh-002-000918^s^81))") in new stack [2012-09-13 10:56:56] VERBOSE[2783] netsock2.c: [2012-09-13 10:56:56] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:56] VERBOSE[2783] netsock2.c: [2012-09-13 10:56:56] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:56] VERBOSE[2783] app_dial.c: [2012-09-13 10:56:56] -- Called SIP/27782115911@Cav-Joh-002 [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog '1472727b-fed04c54-7afa9791@192.168.2.162' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog '5e4012fa61da0f5d4c48a3c2539634b0@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] VERBOSE[2795] app_dial.c: [2012-09-13 10:56:56] -- SIP/Cav-Joh-002-0000086b is making progress passing it to SIP/2026-0000084e [2012-09-13 10:56:56] VERBOSE[2688] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:78] ResetCDR("SIP/2086-00000848", "") in new stack [2012-09-13 10:56:56] VERBOSE[2688] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:79] GotoIf("SIP/2086-00000848", "1?81") in new stack [2012-09-13 10:56:56] VERBOSE[2688] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,81) [2012-09-13 10:56:56] VERBOSE[2688] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:81] ExecIf("SIP/2086-00000848", "1?Dial(SIP/27749065489@Cav-Joh-002,60,gF(all-hangup,s,1)):Dial(SIP/27749065489@Cav-Joh-002,60,gF(all-hangup,s,1)grM(all-call-screening^2086^macro-default-dial-cav-joh-002-000918^s^81))") in new stack [2012-09-13 10:56:56] VERBOSE[2688] netsock2.c: [2012-09-13 10:56:56] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:56] VERBOSE[2688] netsock2.c: [2012-09-13 10:56:56] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:56] VERBOSE[2688] app_dial.c: [2012-09-13 10:56:56] -- Called SIP/27749065489@Cav-Joh-002 [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog '44fe5a2f6a37c7f176cc378d220f1c84@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog '2c5f743b708157b149ef956b7eb16270@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog '2ba1b12f35356dbb58439e9839a38e64@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog '65622eec-d75c281b-ee3a651e@192.168.2.180' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog 'ba74ea63-14ea0d0a-cacfccf9@192.168.2.156' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] VERBOSE[2920] res_agi.c: [2012-09-13 10:56:56] agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2096 [2012-09-13 10:56:56] VERBOSE[2920] res_agi.c: [2012-09-13 10:56:56] -- AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0 [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2096-00000857", "CALLFILENAME=2096_1347526598.2225") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2096-00000857", "2096_1347526598.2225.WAV,ab") in new stack [2012-09-13 10:56:56] VERBOSE[3066] app_mixmonitor.c: [2012-09-13 10:56:56] == Begin MixMonitor Recording SIP/2096-00000857 [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2096-00000857", "TRUNK_DISABLE=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2096-00000857", "0?100:62") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,62) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2096-00000857", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2096-00000857", "CALLFILENAME=1347526598.2225") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2096-00000857", "1?65:66") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,65) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2096-00000857", "1347526598.2225.WAV,ab") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2096-00000857", "OUT_TRUNK_CIDNUM=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2096-00000857", "OUT_TRUNK_CIDNAME=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2096-00000857", "OUT_TRUNK_FORCECID=") in new stack [2012-09-13 10:56:56] VERBOSE[3067] app_mixmonitor.c: [2012-09-13 10:56:56] == Begin MixMonitor Recording SIP/2096-00000857 [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2096-00000857", "all-outgoing-checkcid,s,1") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2096-00000857", "ext_cidname=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2096-00000857", "1?50") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,50) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2096-00000857", "ext_cidnum=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2096-00000857", "ext_cidpres=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2096-00000857", "1?54") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,54) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2096-00000857", "1?56") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,56) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2096-00000857", "1?59") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,59) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2096-00000857", "1?61") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,61) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2096-00000857", "agentid=4031") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2096-00000857", "0?69") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2096-00000857", "agent_cidname=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2096-00000857", "agent_cidnum=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2096-00000857", "1?67") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,67) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2096-00000857", "1?69") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,69) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2096-00000857", "ext_override=") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2096-00000857", "1?100") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,100) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2096-00000857", "1?102") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,102) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2096-00000857", "1?104") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,104) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2096-00000857", "0?105:150") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,150) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2096-00000857", "0?151:175") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,175) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2096-00000857", "0?176:200") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,200) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2096-00000857", "1?202") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,202) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2096-00000857", "1?204") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,204) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2096-00000857", "") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2096-00000857", "0?75:71") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,71) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2096-00000857", "0?72:74") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,74) [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2096-00000857", "CALLSCREEN=NO") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2096-00000857", "0?79") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2096-00000857", "0?79") in new stack [2012-09-13 10:56:56] VERBOSE[2920] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2096-00000857", "/pw_default_credit_clear,da,,agent-pass") in new stack [2012-09-13 10:56:56] VERBOSE[2920] file.c: [2012-09-13 10:56:56] -- Playing 'agent-pass.ulaw' (language 'en') [2012-09-13 10:56:56] VERBOSE[2113] res_musiconhold.c: [2012-09-13 10:56:56] -- Stopped music on hold on SIP/Cav-Joh-002-00000819 [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:16] NoOp("SIP/Cav-Joh-002-00000819", "TIMEOUT") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:17] GotoIf("SIP/Cav-Joh-002-00000819", "0?18:20") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Goto (default-application-acd-prodepartment,s,20) [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:20] GotoIf("SIP/Cav-Joh-002-00000819", "0?21:23") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Goto (default-application-acd-prodepartment,s,23) [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:23] GotoIf("SIP/Cav-Joh-002-00000819", "0?24:26") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Goto (default-application-acd-prodepartment,s,26) [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:26] GotoIf("SIP/Cav-Joh-002-00000819", "0?1000") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:27] GotoIf("SIP/Cav-Joh-002-00000819", "0?1000") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:28] GotoIf("SIP/Cav-Joh-002-00000819", "1?1000") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Goto (default-application-acd-prodepartment,s,1000) [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:1000] Set("SIP/Cav-Joh-002-00000819", "QUEUE_PRIO=0") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:1001] Set("SIP/Cav-Joh-002-00000819", "QUEUE_RULE=") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:1002] Gosub("SIP/Cav-Joh-002-00000819", "default-application-acd-prodepartment,s,1") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-00000819", "HANGUPSIDE=CALLEE") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-00000819", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-00000819", ""=== START QUEUE (default-prodepartment) ==="") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-00000819", "__QUEUENAME=default-prodepartment") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-00000819", "1?8") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Goto (default-application-acd-prodepartment,s,8) [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-00000819", "MONITOR_FILENAME=1347526545.2163") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-00000819", "TIMEOUT(digit)=1") in new stack [2012-09-13 10:56:56] VERBOSE[2113] func_timeout.c: [2012-09-13 10:56:56] -- Digit timeout set to 1.000 [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-00000819", "TIMEOUT(response)=1") in new stack [2012-09-13 10:56:56] VERBOSE[2113] func_timeout.c: [2012-09-13 10:56:56] -- Response timeout set to 1.000 [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-00000819", "__ACD_TO_OUTGOING=1") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-00000819", "CHANNEL(musicclass)=default") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-00000819", "__ALLOW_TRANSFER=t") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-00000819", "CHANNEL(language)=en") in new stack [2012-09-13 10:56:56] VERBOSE[2113] pbx.c: [2012-09-13 10:56:56] -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-00000819", "default-prodepartment,t,,,10,,,,,,") in new stack [2012-09-13 10:56:56] VERBOSE[2113] res_musiconhold.c: [2012-09-13 10:56:56] -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-00000819' [2012-09-13 10:56:56] VERBOSE[32665] res_musiconhold.c: [2012-09-13 10:56:56] -- Stopped music on hold on SIP/Cav-Joh-002-0000079d [2012-09-13 10:56:56] VERBOSE[32665] pbx.c: [2012-09-13 10:56:56] == Spawn extension (default-application-acd-prodepartment, s, 15) exited non-zero on 'SIP/Cav-Joh-002-0000079d' [2012-09-13 10:56:56] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:56] == Using SIP RTP TOS bits 184 [2012-09-13 10:56:56] VERBOSE[1993] netsock2.c: [2012-09-13 10:56:56] == Using SIP RTP CoS mark 5 [2012-09-13 10:56:56] VERBOSE[3068] pbx.c: [2012-09-13 10:56:56] -- Executing [0825531970@default-default:1] Macro("SIP/2092-0000086e", "default-dial-cav-joh-002-000918") in new stack [2012-09-13 10:56:56] VERBOSE[3068] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:1] AGI("SIP/2092-0000086e", "agi://127.0.0.1:4573/extension") in new stack [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog 'b0f5b394-f960f9e7-20c513fe@192.168.2.153' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] WARNING[1993] chan_sip.c: Autodestruct on dialog 'ba6bda87-aea20348-d7a0d931@192.168.2.71' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:56] VERBOSE[2932] res_agi.c: [2012-09-13 10:56:56] agi://127.0.0.1:4573/monitortag: Variable 'FORCE_RECORDING' result is 2128 [2012-09-13 10:56:56] VERBOSE[2932] res_agi.c: [2012-09-13 10:56:56] -- AGI Script agi://127.0.0.1:4573/monitortag completed, returning 0 [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:58] Set("SIP/2128-00000858", "CALLFILENAME=2128_1347526598.2226") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:59] MixMonitor("SIP/2128-00000858", "2128_1347526598.2226.WAV,ab") in new stack [2012-09-13 10:56:56] VERBOSE[3070] app_mixmonitor.c: [2012-09-13 10:56:56] == Begin MixMonitor Recording SIP/2128-00000858 [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:60] Set("SIP/2128-00000858", "TRUNK_DISABLE=") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:61] GotoIf("SIP/2128-00000858", "0?100:62") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,62) [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:62] Set("SIP/2128-00000858", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:63] Set("SIP/2128-00000858", "CALLFILENAME=1347526598.2226") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:64] GotoIf("SIP/2128-00000858", "1?65:66") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Goto (macro-default-dial-cav-joh-002-000918,s,65) [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:65] MixMonitor("SIP/2128-00000858", "1347526598.2226.WAV,ab") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:66] Set("SIP/2128-00000858", "OUT_TRUNK_CIDNUM=") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:67] Set("SIP/2128-00000858", "OUT_TRUNK_CIDNAME=") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:68] Set("SIP/2128-00000858", "OUT_TRUNK_FORCECID=") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@macro-default-dial-cav-joh-002-000918:69] Gosub("SIP/2128-00000858", "all-outgoing-checkcid,s,1") in new stack [2012-09-13 10:56:56] VERBOSE[3071] app_mixmonitor.c: [2012-09-13 10:56:56] == Begin MixMonitor Recording SIP/2128-00000858 [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:1] Set("SIP/2128-00000858", "ext_cidname=") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:2] GotoIf("SIP/2128-00000858", "1?50") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,50) [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:50] Set("SIP/2128-00000858", "ext_cidnum=") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:51] Set("SIP/2128-00000858", "ext_cidpres=") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:52] GotoIf("SIP/2128-00000858", "1?54") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,54) [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:54] GotoIf("SIP/2128-00000858", "1?56") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,56) [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:56] GotoIf("SIP/2128-00000858", "1?59") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,59) [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:59] GotoIf("SIP/2128-00000858", "1?61") in new stack [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Goto (all-outgoing-checkcid,s,61) [2012-09-13 10:56:56] VERBOSE[2932] pbx.c: [2012-09-13 10:56:56] -- Executing [s@all-outgoing-checkcid:61] Set("SIP/2128-00000858", "agentid=6083") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:62] GotoIf("SIP/2128-00000858", "0?69") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:63] Set("SIP/2128-00000858", "agent_cidname=") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:64] Set("SIP/2128-00000858", "agent_cidnum=") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:65] GotoIf("SIP/2128-00000858", "1?67") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,67) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:67] GotoIf("SIP/2128-00000858", "1?69") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,69) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:69] Set("SIP/2128-00000858", "ext_override=") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:70] GotoIf("SIP/2128-00000858", "1?100") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,100) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:100] GotoIf("SIP/2128-00000858", "1?102") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,102) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:102] GotoIf("SIP/2128-00000858", "1?104") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,104) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:104] GotoIf("SIP/2128-00000858", "0?105:150") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,150) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:150] GotoIf("SIP/2128-00000858", "0?151:175") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,175) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:175] GotoIf("SIP/2128-00000858", "0?176:200") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,200) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:200] GotoIf("SIP/2128-00000858", "1?202") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,202) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:202] GotoIf("SIP/2128-00000858", "1?204") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (all-outgoing-checkcid,s,204) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@all-outgoing-checkcid:204] Return("SIP/2128-00000858", "") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@macro-default-dial-cav-joh-002-000918:70] GotoIf("SIP/2128-00000858", "0?75:71") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (macro-default-dial-cav-joh-002-000918,s,71) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@macro-default-dial-cav-joh-002-000918:71] GotoIf("SIP/2128-00000858", "0?72:74") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Goto (macro-default-dial-cav-joh-002-000918,s,74) [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@macro-default-dial-cav-joh-002-000918:74] Set("SIP/2128-00000858", "CALLSCREEN=NO") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@macro-default-dial-cav-joh-002-000918:75] GotoIf("SIP/2128-00000858", "0?79") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@macro-default-dial-cav-joh-002-000918:76] GotoIf("SIP/2128-00000858", "0?79") in new stack [2012-09-13 10:56:57] VERBOSE[2932] pbx.c: [2012-09-13 10:56:57] -- Executing [s@macro-default-dial-cav-joh-002-000918:77] Authenticate("SIP/2128-00000858", "/pw_default_credit_clear,da,,agent-pass") in new stack [2012-09-13 10:56:57] WARNING[1993] chan_sip.c: Autodestruct on dialog '64732a367fd339664e9b43fa67bbcb58@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:57] WARNING[1993] chan_sip.c: Autodestruct on dialog '3e725e90-624b39a9-341ce4d2@192.168.2.51' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:57] VERBOSE[2932] file.c: [2012-09-13 10:56:57] -- Playing 'agent-pass.ulaw' (language 'en') [2012-09-13 10:56:57] VERBOSE[3022] res_agi.c: [2012-09-13 10:56:57] agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!! [2012-09-13 10:56:57] WARNING[1993] chan_sip.c: Autodestruct on dialog '606b69a8-a7cb1a63-4279e5da@192.168.2.99' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:57] VERBOSE[31979] res_musiconhold.c: [2012-09-13 10:56:57] -- Stopped music on hold on SIP/Cav-Joh-002-00000781 [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:16] NoOp("SIP/Cav-Joh-002-00000781", "TIMEOUT") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:17] GotoIf("SIP/Cav-Joh-002-00000781", "0?18:20") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Goto (default-application-acd-prodepartment,s,20) [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:20] GotoIf("SIP/Cav-Joh-002-00000781", "0?21:23") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Goto (default-application-acd-prodepartment,s,23) [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:23] GotoIf("SIP/Cav-Joh-002-00000781", "0?24:26") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Goto (default-application-acd-prodepartment,s,26) [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:26] GotoIf("SIP/Cav-Joh-002-00000781", "0?1000") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:27] GotoIf("SIP/Cav-Joh-002-00000781", "0?1000") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:28] GotoIf("SIP/Cav-Joh-002-00000781", "1?1000") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Goto (default-application-acd-prodepartment,s,1000) [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:1000] Set("SIP/Cav-Joh-002-00000781", "QUEUE_PRIO=0") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:1001] Set("SIP/Cav-Joh-002-00000781", "QUEUE_RULE=") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:1002] Gosub("SIP/Cav-Joh-002-00000781", "default-application-acd-prodepartment,s,1") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-00000781", "HANGUPSIDE=CALLEE") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-00000781", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-00000781", ""=== START QUEUE (default-prodepartment) ==="") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-00000781", "__QUEUENAME=default-prodepartment") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-00000781", "1?8") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Goto (default-application-acd-prodepartment,s,8) [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-00000781", "MONITOR_FILENAME=1347526387.2011") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-00000781", "TIMEOUT(digit)=1") in new stack [2012-09-13 10:56:57] VERBOSE[31979] func_timeout.c: [2012-09-13 10:56:57] -- Digit timeout set to 1.000 [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-00000781", "TIMEOUT(response)=1") in new stack [2012-09-13 10:56:57] VERBOSE[31979] func_timeout.c: [2012-09-13 10:56:57] -- Response timeout set to 1.000 [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-00000781", "__ACD_TO_OUTGOING=1") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-00000781", "CHANNEL(musicclass)=default") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-00000781", "__ALLOW_TRANSFER=t") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-00000781", "CHANNEL(language)=en") in new stack [2012-09-13 10:56:57] VERBOSE[31979] pbx.c: [2012-09-13 10:56:57] -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-00000781", "default-prodepartment,t,,,10,,,,,,") in new stack [2012-09-13 10:56:57] VERBOSE[31979] res_musiconhold.c: [2012-09-13 10:56:57] -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-00000781' [2012-09-13 10:56:57] VERBOSE[3026] res_agi.c: [2012-09-13 10:56:57] agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!! [2012-09-13 10:56:58] VERBOSE[29794] res_musiconhold.c: [2012-09-13 10:56:58] -- Stopped music on hold on SIP/Cav-Joh-002-00000718 [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:16] NoOp("SIP/Cav-Joh-002-00000718", "TIMEOUT") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:17] GotoIf("SIP/Cav-Joh-002-00000718", "0?18:20") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Goto (default-application-acd-prodepartment,s,20) [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:20] GotoIf("SIP/Cav-Joh-002-00000718", "0?21:23") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Goto (default-application-acd-prodepartment,s,23) [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:23] GotoIf("SIP/Cav-Joh-002-00000718", "0?24:26") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Goto (default-application-acd-prodepartment,s,26) [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:26] GotoIf("SIP/Cav-Joh-002-00000718", "0?1000") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:27] GotoIf("SIP/Cav-Joh-002-00000718", "0?1000") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:28] GotoIf("SIP/Cav-Joh-002-00000718", "1?1000") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Goto (default-application-acd-prodepartment,s,1000) [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:1000] Set("SIP/Cav-Joh-002-00000718", "QUEUE_PRIO=0") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:1001] Set("SIP/Cav-Joh-002-00000718", "QUEUE_RULE=") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:1002] Gosub("SIP/Cav-Joh-002-00000718", "default-application-acd-prodepartment,s,1") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-00000718", "HANGUPSIDE=CALLEE") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-00000718", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-00000718", ""=== START QUEUE (default-prodepartment) ==="") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-00000718", "__QUEUENAME=default-prodepartment") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-00000718", "1?8") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Goto (default-application-acd-prodepartment,s,8) [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-00000718", "MONITOR_FILENAME=1347526265.1906") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-00000718", "TIMEOUT(digit)=1") in new stack [2012-09-13 10:56:58] VERBOSE[29794] func_timeout.c: [2012-09-13 10:56:58] -- Digit timeout set to 1.000 [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-00000718", "TIMEOUT(response)=1") in new stack [2012-09-13 10:56:58] VERBOSE[29794] func_timeout.c: [2012-09-13 10:56:58] -- Response timeout set to 1.000 [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-00000718", "__ACD_TO_OUTGOING=1") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-00000718", "CHANNEL(musicclass)=default") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-00000718", "__ALLOW_TRANSFER=t") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-00000718", "CHANNEL(language)=en") in new stack [2012-09-13 10:56:58] VERBOSE[29794] pbx.c: [2012-09-13 10:56:58] -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-00000718", "default-prodepartment,t,,,10,,,,,,") in new stack [2012-09-13 10:56:58] VERBOSE[29794] res_musiconhold.c: [2012-09-13 10:56:58] -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-00000718' [2012-09-13 10:56:58] WARNING[1993] chan_sip.c: Autodestruct on dialog '68df55f725d5990c296b3df63800b99d@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:58] VERBOSE[2015] res_agi.c: [2012-09-13 10:56:58] agi://127.0.0.1:4573/dial: Variable 'EXT_ACCODE' result is not defined!!! [2012-09-13 10:56:58] WARNING[1993] chan_sip.c: Autodestruct on dialog '149fb0d3-b3048aec-56db1321@192.168.2.69' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:58] VERBOSE[3036] res_agi.c: [2012-09-13 10:56:58] agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!! [2012-09-13 10:56:58] WARNING[1993] chan_sip.c: Autodestruct on dialog '7bca7d4e0b9dd55c3b008f1334ac70bf@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:59] VERBOSE[31408] res_musiconhold.c: [2012-09-13 10:56:59] -- Stopped music on hold on SIP/Cav-Joh-002-0000075a [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:16] NoOp("SIP/Cav-Joh-002-0000075a", "TIMEOUT") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:17] GotoIf("SIP/Cav-Joh-002-0000075a", "0?18:20") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Goto (default-application-acd-prodepartment,s,20) [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:20] GotoIf("SIP/Cav-Joh-002-0000075a", "0?21:23") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Goto (default-application-acd-prodepartment,s,23) [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:23] GotoIf("SIP/Cav-Joh-002-0000075a", "0?24:26") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Goto (default-application-acd-prodepartment,s,26) [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:26] GotoIf("SIP/Cav-Joh-002-0000075a", "0?1000") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:27] GotoIf("SIP/Cav-Joh-002-0000075a", "0?1000") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:28] GotoIf("SIP/Cav-Joh-002-0000075a", "1?1000") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Goto (default-application-acd-prodepartment,s,1000) [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:1000] Set("SIP/Cav-Joh-002-0000075a", "QUEUE_PRIO=0") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:1001] Set("SIP/Cav-Joh-002-0000075a", "QUEUE_RULE=") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:1002] Gosub("SIP/Cav-Joh-002-0000075a", "default-application-acd-prodepartment,s,1") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:1] Set("SIP/Cav-Joh-002-0000075a", "HANGUPSIDE=CALLEE") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:2] Set("SIP/Cav-Joh-002-0000075a", "AUDIOHOOK_INHERIT(MixMonitor)=yes") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:3] NoOp("SIP/Cav-Joh-002-0000075a", ""=== START QUEUE (default-prodepartment) ==="") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:4] Set("SIP/Cav-Joh-002-0000075a", "__QUEUENAME=default-prodepartment") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:5] GotoIf("SIP/Cav-Joh-002-0000075a", "1?8") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Goto (default-application-acd-prodepartment,s,8) [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:8] Set("SIP/Cav-Joh-002-0000075a", "MONITOR_FILENAME=1347526337.1972") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:9] Set("SIP/Cav-Joh-002-0000075a", "TIMEOUT(digit)=1") in new stack [2012-09-13 10:56:59] VERBOSE[31408] func_timeout.c: [2012-09-13 10:56:59] -- Digit timeout set to 1.000 [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:10] Set("SIP/Cav-Joh-002-0000075a", "TIMEOUT(response)=1") in new stack [2012-09-13 10:56:59] VERBOSE[31408] func_timeout.c: [2012-09-13 10:56:59] -- Response timeout set to 1.000 [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:11] Set("SIP/Cav-Joh-002-0000075a", "__ACD_TO_OUTGOING=1") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:12] Set("SIP/Cav-Joh-002-0000075a", "CHANNEL(musicclass)=default") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:13] Set("SIP/Cav-Joh-002-0000075a", "__ALLOW_TRANSFER=t") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:14] Set("SIP/Cav-Joh-002-0000075a", "CHANNEL(language)=en") in new stack [2012-09-13 10:56:59] VERBOSE[31408] pbx.c: [2012-09-13 10:56:59] -- Executing [s@default-application-acd-prodepartment:15] Queue("SIP/Cav-Joh-002-0000075a", "default-prodepartment,t,,,10,,,,,,") in new stack [2012-09-13 10:56:59] VERBOSE[31408] res_musiconhold.c: [2012-09-13 10:56:59] -- Started music on hold, class 'default', on channel 'SIP/Cav-Joh-002-0000075a' [2012-09-13 10:56:59] VERBOSE[3037] res_agi.c: [2012-09-13 10:56:59] agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!! [2012-09-13 10:56:59] WARNING[1993] chan_sip.c: Autodestruct on dialog '4749fae4-ce4cbd63-6307d1e2@192.168.2.68' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:59] WARNING[1993] chan_sip.c: Autodestruct on dialog '4eb8c387-d217a860-bcde413d@192.168.2.128' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:59] VERBOSE[2783] app_dial.c: [2012-09-13 10:56:59] -- SIP/Cav-Joh-002-0000086c is ringing [2012-09-13 10:56:59] VERBOSE[2783] app_dial.c: [2012-09-13 10:56:59] -- SIP/Cav-Joh-002-0000086c is making progress passing it to SIP/2118-0000084d [2012-09-13 10:56:59] VERBOSE[2485] app_dial.c: [2012-09-13 10:56:59] -- SIP/Cav-Joh-002-0000086a is ringing [2012-09-13 10:56:59] VERBOSE[2485] app_dial.c: [2012-09-13 10:56:59] -- SIP/Cav-Joh-002-0000086a is making progress passing it to SIP/2093-0000083f [2012-09-13 10:56:59] VERBOSE[2688] app_dial.c: [2012-09-13 10:56:59] -- SIP/Cav-Joh-002-0000086d is making progress passing it to SIP/2086-00000848 [2012-09-13 10:56:59] WARNING[1993] chan_sip.c: Autodestruct on dialog 'e04fb61f-c229253a-e669af51@192.168.2.89' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:59] VERBOSE[2932] file.c: [2012-09-13 10:56:59] -- Playing 'auth-thankyou.ulaw' (language 'en') [2012-09-13 10:56:59] WARNING[1993] chan_sip.c: Autodestruct on dialog '5847b3de-86bf3847-cc650eb0@192.168.2.74' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:56:59] VERBOSE[2906] file.c: [2012-09-13 10:56:59] -- Playing 'auth-thankyou.ulaw' (language 'en') [2012-09-13 10:57:00] WARNING[1993] chan_sip.c: Autodestruct on dialog '58e78a78-9843ad3-58a9de26@192.168.2.85' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:57:00] VERBOSE[3040] res_agi.c: [2012-09-13 10:57:00] agi://127.0.0.1:4573/extension: Variable 'PHONE_EXTEN_HD' result is not defined!!! [2012-09-13 10:57:00] VERBOSE[2795] app_dial.c: [2012-09-13 10:57:00] -- SIP/Cav-Joh-002-0000086b is ringing [2012-09-13 10:57:00] WARNING[1993] chan_sip.c: Autodestruct on dialog '2c234cee117838a80850b81c4cef9aa3@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:57:00] WARNING[1993] chan_sip.c: Autodestruct on dialog 'c887a3b6-5848f5a7-98f53788@192.168.2.175' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:57:00] VERBOSE[2825] file.c: [2012-09-13 10:57:00] -- Playing 'auth-thankyou.ulaw' (language 'en') [2012-09-13 10:57:00] WARNING[1993] chan_sip.c: Autodestruct on dialog '4be66cd-c263a86a-4dd2017b@192.168.2.172' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:57:00] WARNING[1993] chan_sip.c: Autodestruct on dialog '7b47c3101fbfdaee4333f90d62080af7@172.20.8.114:5060' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:57:00] WARNING[1993] chan_sip.c: Autodestruct on dialog '9128ff05-67e7b42e-a128d067@192.168.2.57' with owner in place (Method: BYE). Rescheduling destruction for 10000 ms [2012-09-13 10:57:00] VERBOSE[2983] res_agi.c: [2012-09-13 10:57:00] agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING: Variable 'AUTO_RECORDING' result is 2108 [2012-09-13 10:57:00] VERBOSE[2983] res_agi.c: [2012-09-13 10:57:00] -- AGI Script agi://127.0.0.1:4573/monitortag?arg1=AUTO_RECORDING completed, returning 0 [2012-09-13 10:57:00] VERBOSE[2983] pbx.c: [2012-09-13 10:57:00] -- Executing [s@macro-default-dial-cav-joh-002-000918:54] Set("SIP/2108-00000860", "TOUCH_MONITOR=2108_1347526605.2234") in new stack [2012-09-13 10:57:00] VERBOSE[2983] pbx.c: [2012-09-13 10:57:00] -- Executing [s@macro-default-dial-cav-joh-002-000918:55] Set("SIP/2108-00000860", "TOUCH_MIXMONITOR=2108_1347526605.2234")