[Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-pstn:1] Macro("SIP/server2_ecs-00000183", "teliosIntegration,900") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-teliosIntegration:1] Set("SIP/server2_ecs-00000183", "__FROM_DID=900") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-teliosIntegration:2] ExecIf("SIP/server2_ecs-00000183", "1?Set(CALLERID(name)=534889944)") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-teliosIntegration:3] Macro("SIP/server2_ecs-00000183", "setInVars,900") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-setInVars:1] Set("SIP/server2_ecs-00000183", "__inServer=asterisk-test1.ecs.test.colos.telecats.nl") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-setInVars:2] Set("SIP/server2_ecs-00000183", "__inChannel=SIP/server2_ecs-00000183") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-setInVars:3] Set("SIP/server2_ecs-00000183", "__outCallerIDName=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-setInVars:4] Set("SIP/server2_ecs-00000183", "__inUniqueID=1333712367.124791") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-setInVars:5] MacroExit("SIP/server2_ecs-00000183", "") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-teliosIntegration:4] MacroExit("SIP/server2_ecs-00000183", "") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-pstn:2] ExecIf("SIP/server2_ecs-00000183", "0 ?Set(CALLERID(name)=534889944)") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-pstn:3] Set("SIP/server2_ecs-00000183", "CHANNEL(musicclass)=none") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-pstn:4] Set("SIP/server2_ecs-00000183", "__MOHCLASS=none") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-pstn:5] Set("SIP/server2_ecs-00000183", "__CALLINGPRES_SV=allowed_not_screened") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-pstn:6] Set("SIP/server2_ecs-00000183", "CALLERPRES()=allowed_not_screened") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-pstn:7] Goto("SIP/server2_ecs-00000183", "from-internal,900,1") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Goto (from-internal,900,1) [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:1] Macro("SIP/server2_ecs-00000183", "user-callerid,") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/server2_ecs-00000183", "AMPUSER=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/server2_ecs-00000183", "0?report") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/server2_ecs-00000183", "1?Set(REALCALLERIDNUM=534889944)") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:4] Set("SIP/server2_ecs-00000183", "AMPUSER=") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/server2_ecs-00000183", "AMPUSERCIDNAME=") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/server2_ecs-00000183", "1?report") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Goto (macro-user-callerid,s,11) [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:11] GotoIf("SIP/server2_ecs-00000183", "0?continue") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:12] Set("SIP/server2_ecs-00000183", "__TTL=64") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:13] GotoIf("SIP/server2_ecs-00000183", "1?continue") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Goto (macro-user-callerid,s,24) [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:24] Set("SIP/server2_ecs-00000183", "CALLERID(number)=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:25] Set("SIP/server2_ecs-00000183", "CALLERID(name)=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-user-callerid:26] Set("SIP/server2_ecs-00000183", "CHANNEL(language)=nl") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:2] Answer("SIP/server2_ecs-00000183", "") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:3] Macro("SIP/server2_ecs-00000183", "blkvm-set,reset") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-blkvm-set:1] ExecIf("SIP/server2_ecs-00000183", "1?Set(__BLKVM_CHANNEL=SIP/server2_ecs-00000183)") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-blkvm-set:2] Set("SIP/server2_ecs-00000183", "SHARED(BLKVM,SIP/server2_ecs-00000183)=TRUE") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-blkvm-set:3] Set("SIP/server2_ecs-00000183", "GOSUB_RETVAL=TRUE") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-blkvm-set:4] MacroExit("SIP/server2_ecs-00000183", "") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:4] ExecIf("SIP/server2_ecs-00000183", "1?Set(_DIAL_OPTIONS=trM(auto-blkvm))") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:5] Set("SIP/server2_ecs-00000183", "__NODEST=900") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:6] Set("SIP/server2_ecs-00000183", "MONITOR_FILENAME=/var/spool/asterisk/monitor/20120406/q900-20120406-133927-1333712367.124791") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:7] Set("SIP/server2_ecs-00000183", "__MOHCLASS=Coldplay") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:8] Set("SIP/server2_ecs-00000183", "CHANNEL(musicclass)=Coldplay") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:9] Set("SIP/server2_ecs-00000183", "__CWIGNORE=TRUE") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:10] Macro("SIP/server2_ecs-00000183", "agent-integration,") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:1] NoOp("SIP/server2_ecs-00000183", "Agent module integration") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:2] Set("SIP/server2_ecs-00000183", "__monitorFilename=/var/spool/asterisk/monitor/20120406/q900-20120406-133927-1333712367.124791") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:3] Set("SIP/server2_ecs-00000183", "__queueEntered=1333712367") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:4] Set("SIP/server2_ecs-00000183", "__queueUniqueId=1333712367.124791") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:5] Set("SIP/server2_ecs-00000183", "__queueId=900") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:6] Set("SIP/server2_ecs-00000183", "__TRANSFER_CONTEXT=agent-xfer") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:7] AGI("SIP/server2_ecs-00000183", "agent-url.php,900") in new stack [Apr 6 13:39:27] VERBOSE[5679] res_agi.c: -- Launched AGI Script /usr/share/asterisk/agi-bin/agent-url.php [Apr 6 13:39:27] VERBOSE[5679] res_agi.c: agent-url.php,900: No section for queue '900' in /etc/asterisk/queues_cti.conf, using 'default' [Apr 6 13:39:27] VERBOSE[5679] res_agi.c: agent-url.php,900: Set queue url to: http://crm-server/lookup?agent=[A]&queue=900&uniqueid=[U] [Apr 6 13:39:27] VERBOSE[5679] res_agi.c: -- AGI Script agent-url.php completed, returning 0 [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [s@macro-agent-integration:8] MacroExit("SIP/server2_ecs-00000183", "") in new stack [Apr 6 13:39:27] VERBOSE[5679] pbx.c: -- Executing [900@from-internal:11] Queue("SIP/server2_ecs-00000183", "900,t,http://crm-server/lookup?agent=[A]&queue=900&uniqueid=[U],") in new stack [Apr 6 13:39:27] VERBOSE[5679] res_musiconhold.c: -- Started music on hold, class 'Coldplay', on SIP/server2_ecs-00000183 [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:1] Set("Local/300@from-queue-lookup-70fb;2", "_agentId=300") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:2] Set("Local/300@from-queue-lookup-70fb;2", "_queueId=900") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:3] Set("Local/300@from-queue-lookup-70fb;2", "_agentChan=Local/300@from-queue-lookup/n") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:4] Set("Local/300@from-queue-lookup-70fb;2", "_queueCli=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:5] AGI("Local/300@from-queue-lookup-70fb;2", "agent-lookup.php,300") in new stack [Apr 6 13:39:27] VERBOSE[5682] res_agi.c: -- Launched AGI Script /usr/share/asterisk/agi-bin/agent-lookup.php [Apr 6 13:39:27] VERBOSE[5685] manager.c: == Manager 'phpagi' logged on from 127.0.0.1 [Apr 6 13:39:27] VERBOSE[5682] res_agi.c: agent-lookup.php,300: Lookup agent 300 [Apr 6 13:39:27] VERBOSE[5682] res_agi.c: agent-lookup.php,300: Agent 300 exists [Apr 6 13:39:27] VERBOSE[5682] res_agi.c: agent-lookup.php,300: Agent 300 is at extension '200' [Apr 6 13:39:27] VERBOSE[5682] res_agi.c: agent-lookup.php,300: Agents language is 'nl' [Apr 6 13:39:27] VERBOSE[5685] manager.c: == Manager 'phpagi' logged off from 127.0.0.1 [Apr 6 13:39:27] VERBOSE[5682] res_agi.c: -- AGI Script agent-lookup.php completed, returning 0 [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:6] GotoIf("Local/300@from-queue-lookup-70fb;2", "0?hangup") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:7] GotoIf("Local/300@from-queue-lookup-70fb;2", "0?noaa") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:8] SIPAddHeader("Local/300@from-queue-lookup-70fb;2", "Alert-Info: Auto Answer") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:9] SIPAddHeader("Local/300@from-queue-lookup-70fb;2", "Call-Info: \; Answer-After=0") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:10] Set("Local/300@from-queue-lookup-70fb;2", "__SPYGROUP=Agent/300") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:11] ExecIf("Local/300@from-queue-lookup-70fb;2", "1?Macro(queuelog,900,1333712367.124791,Local/300@from-queue-lookup/n,AGENTATTEMPT)") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [s@macro-queuelog:1] QueueLog("Local/300@from-queue-lookup-70fb;2", "900,1333712367.124791,Local/300@from-queue-lookup/n,AGENTATTEMPT,||||") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [s@macro-queuelog:2] MacroExit("Local/300@from-queue-lookup-70fb;2", "") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:12] Set("Local/300@from-queue-lookup-70fb;2", "completedBy=caller") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:13] ExecIf("Local/300@from-queue-lookup-70fb;2", "0?Agi()") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:14] Dial("Local/300@from-queue-lookup-70fb;2", "Local/200@agent-dial,60,grM(agent-answered^Local/300@from-queue-lookup-70fb;2)") in new stack [Apr 6 13:39:27] VERBOSE[5682] app_dial.c: -- Called Local/200@agent-dial [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@agent-dial:1] NoCDR("Local/200@agent-dial-d14d;2", "") in new stack [Apr 6 13:39:27] VERBOSE[5679] app_queue.c: -- Local/300@from-queue-lookup-70fb;1 is ringing [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@agent-dial:2] Goto("Local/200@agent-dial-d14d;2", "from-internal,200,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (from-internal,200,1) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@from-internal:1] Macro("Local/200@agent-dial-d14d;2", "user-callerid,LIMIT,") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-user-callerid:1] Set("Local/200@agent-dial-d14d;2", "AMPUSER=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("Local/200@agent-dial-d14d;2", "1?report") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-user-callerid,s,11) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-user-callerid:11] GotoIf("Local/200@agent-dial-d14d;2", "1?continue") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-user-callerid,s,24) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-user-callerid:24] Set("Local/200@agent-dial-d14d;2", "CALLERID(number)=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-user-callerid:25] Set("Local/200@agent-dial-d14d;2", "CALLERID(name)=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-user-callerid:26] Set("Local/200@agent-dial-d14d;2", "CHANNEL(language)=nl") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@from-internal:2] Set("Local/200@agent-dial-d14d;2", "MOHCLASS=Coldplay") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@from-internal:3] Set("Local/200@agent-dial-d14d;2", "_NODEST=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@from-internal:4] Macro("Local/200@agent-dial-d14d;2", "record-enable,534889944,OUT,") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-record-enable:1] GotoIf("Local/200@agent-dial-d14d;2", "1?check") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-record-enable,s,4) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-record-enable:4] ExecIf("Local/200@agent-dial-d14d;2", "0?MacroExit()") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-record-enable:5] GotoIf("Local/200@agent-dial-d14d;2", "0?Group:OUT") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-record-enable,s,14) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-record-enable:14] GotoIf("Local/200@agent-dial-d14d;2", "0?IN") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-record-enable:15] ExecIf("Local/200@agent-dial-d14d;2", "1?MacroExit()") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@from-internal:5] Macro("Local/200@agent-dial-d14d;2", "dialout-trunk,2,200,") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("Local/200@agent-dial-d14d;2", "DIAL_TRUNK=2") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("Local/200@agent-dial-d14d;2", "0?sub-pincheck,s,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("Local/200@agent-dial-d14d;2", "0?disabletrunk,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("Local/200@agent-dial-d14d;2", "DIAL_NUMBER=200") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("Local/200@agent-dial-d14d;2", "DIAL_TRUNK_OPTIONS=tr") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("Local/200@agent-dial-d14d;2", "OUTBOUND_GROUP=OUT_2") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("Local/200@agent-dial-d14d;2", "1?nomax") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-dialout-trunk,s,9) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("Local/200@agent-dial-d14d;2", "0?skipoutcid") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("Local/200@agent-dial-d14d;2", "DIAL_TRUNK_OPTIONS=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("Local/200@agent-dial-d14d;2", "outbound-callerid,2") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("Local/200@agent-dial-d14d;2", "1?Set(CALLERPRES()=allowed_not_screened)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("Local/200@agent-dial-d14d;2", "1?Set(REALCALLERIDNUM=534889944)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("Local/200@agent-dial-d14d;2", "1?normcid") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-outbound-callerid,s,6) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("Local/200@agent-dial-d14d;2", "USEROUTCID=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("Local/200@agent-dial-d14d;2", "EMERGENCYCID=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("Local/200@agent-dial-d14d;2", "TRUNKOUTCID=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("Local/200@agent-dial-d14d;2", "1?trunkcid") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-outbound-callerid,s,12) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("Local/200@agent-dial-d14d;2", "0?sub-flp-2,s,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("Local/200@agent-dial-d14d;2", "OUTNUM=200") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("Local/200@agent-dial-d14d;2", "custom=SIP/server1_ecs") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("Local/200@agent-dial-d14d;2", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay))") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay)M(confirm))") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:17] Macro("Local/200@agent-dial-d14d;2", "dialout-trunk-predial-hook,") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("Local/200@agent-dial-d14d;2", "") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("Local/200@agent-dial-d14d;2", "0?bypass,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:19] GotoIf("Local/200@agent-dial-d14d;2", "0?customtrunk") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:20] Dial("Local/200@agent-dial-d14d;2", "SIP/server1_ecs/200,300,M(setmusic^Coldplay)") in new stack [Apr 6 13:39:27] WARNING[5686] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Unknown) [Apr 6 13:39:27] VERBOSE[5686] app_dial.c: == Everyone is busy/congested at this time (1:0/0/1) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:21] NoOp("Local/200@agent-dial-d14d;2", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 20") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:22] Goto("Local/200@agent-dial-d14d;2", "s-CHANUNAVAIL,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-dialout-trunk,s-CHANUNAVAIL,1) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("Local/200@agent-dial-d14d;2", "RC=20") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("Local/200@agent-dial-d14d;2", "20,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-dialout-trunk,20,1) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [20@macro-dialout-trunk:1] Goto("Local/200@agent-dial-d14d;2", "continue,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-dialout-trunk,continue,1) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [continue@macro-dialout-trunk:1] GotoIf("Local/200@agent-dial-d14d;2", "1?noreport") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-dialout-trunk,continue,3) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [continue@macro-dialout-trunk:3] NoOp("Local/200@agent-dial-d14d;2", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 20 - failing through to other trunks") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [continue@macro-dialout-trunk:4] Set("Local/200@agent-dial-d14d;2", "CALLERID(number)=534889944") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [200@from-internal:6] Macro("Local/200@agent-dial-d14d;2", "dialout-trunk,1,200,") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("Local/200@agent-dial-d14d;2", "DIAL_TRUNK=1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("Local/200@agent-dial-d14d;2", "0?sub-pincheck,s,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("Local/200@agent-dial-d14d;2", "0?disabletrunk,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("Local/200@agent-dial-d14d;2", "DIAL_NUMBER=200") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("Local/200@agent-dial-d14d;2", "DIAL_TRUNK_OPTIONS=tr") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("Local/200@agent-dial-d14d;2", "OUTBOUND_GROUP=OUT_1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("Local/200@agent-dial-d14d;2", "1?nomax") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-dialout-trunk,s,9) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("Local/200@agent-dial-d14d;2", "0?skipoutcid") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("Local/200@agent-dial-d14d;2", "DIAL_TRUNK_OPTIONS=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("Local/200@agent-dial-d14d;2", "outbound-callerid,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("Local/200@agent-dial-d14d;2", "1?Set(CALLERPRES()=allowed_not_screened)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(REALCALLERIDNUM=534889944)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("Local/200@agent-dial-d14d;2", "1?normcid") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-outbound-callerid,s,6) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("Local/200@agent-dial-d14d;2", "USEROUTCID=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("Local/200@agent-dial-d14d;2", "EMERGENCYCID=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("Local/200@agent-dial-d14d;2", "TRUNKOUTCID=") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("Local/200@agent-dial-d14d;2", "1?trunkcid") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Goto (macro-outbound-callerid,s,12) [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("Local/200@agent-dial-d14d;2", "0?sub-flp-1,s,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("Local/200@agent-dial-d14d;2", "OUTNUM=200") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("Local/200@agent-dial-d14d;2", "custom=SIP/server2_ecs") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("Local/200@agent-dial-d14d;2", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay))") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("Local/200@agent-dial-d14d;2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay)M(confirm))") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:17] Macro("Local/200@agent-dial-d14d;2", "dialout-trunk-predial-hook,") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("Local/200@agent-dial-d14d;2", "") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("Local/200@agent-dial-d14d;2", "0?bypass,1") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:19] GotoIf("Local/200@agent-dial-d14d;2", "0?customtrunk") in new stack [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-dialout-trunk:20] Dial("Local/200@agent-dial-d14d;2", "SIP/server2_ecs/200,300,M(setmusic^Coldplay)") in new stack [Apr 6 13:39:27] VERBOSE[5686] netsock2.c: == Using SIP RTP TOS bits 184 [Apr 6 13:39:27] VERBOSE[5686] netsock2.c: == Using SIP RTP CoS mark 5 [Apr 6 13:39:27] VERBOSE[5686] app_dial.c: -- Called SIP/server2_ecs/200 [Apr 6 13:39:27] VERBOSE[5686] app_dial.c: -- SIP/server2_ecs-00000184 answered Local/200@agent-dial-d14d;2 [Apr 6 13:39:27] VERBOSE[5686] pbx.c: -- Executing [s@macro-setmusic:1] Set("SIP/server2_ecs-00000184", "CHANNEL(musicclass)=Coldplay") in new stack [Apr 6 13:39:27] VERBOSE[5682] app_dial.c: -- Local/200@agent-dial-d14d;1 answered Local/300@from-queue-lookup-70fb;2 [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-answered:1] NoOp("Local/200@agent-dial-d14d;1", "Agent 300 answered call for queue 900") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-answered:2] ExecIf("Local/200@agent-dial-d14d;1", "0?Agi()") in new stack [Apr 6 13:39:27] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-answered:3] MacroExit("Local/200@agent-dial-d14d;1", "") in new stack [Apr 6 13:39:27] VERBOSE[5679] app_queue.c: -- Local/300@from-queue-lookup-70fb;1 answered SIP/server2_ecs-00000183 for queue (900) [Apr 6 13:39:27] VERBOSE[5679] res_musiconhold.c: -- Stopped music on hold on SIP/server2_ecs-00000183 [Apr 6 13:39:28] VERBOSE[5686] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("Local/200@agent-dial-d14d;2", "hangupcall,") in new stack [Apr 6 13:39:28] VERBOSE[5686] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("Local/200@agent-dial-d14d;2", "1?theend") in new stack [Apr 6 13:39:28] VERBOSE[5686] pbx.c: -- Goto (macro-hangupcall,s,3) [Apr 6 13:39:28] VERBOSE[5686] pbx.c: -- Executing [s@macro-hangupcall:3] Hangup("Local/200@agent-dial-d14d;2", "") in new stack [Apr 6 13:39:28] VERBOSE[5686] app_macro.c: == Spawn extension (macro-hangupcall, s, 3) exited non-zero on 'Local/200@agent-dial-d14d;2' in macro 'hangupcall' [Apr 6 13:39:28] VERBOSE[5686] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'Local/200@agent-dial-d14d;2' [Apr 6 13:39:28] VERBOSE[5686] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'Local/200@agent-dial-d14d;2' in macro 'dialout-trunk' [Apr 6 13:39:28] VERBOSE[5686] pbx.c: == Spawn extension (from-internal, 200, 6) exited non-zero on 'Local/200@agent-dial-d14d;2' [Apr 6 13:40:01] VERBOSE[24107] asterisk.c: -- Remote UNIX connection [Apr 6 13:40:01] VERBOSE[5701] asterisk.c: -- Remote UNIX connection disconnected [Apr 6 13:40:01] VERBOSE[24107] asterisk.c: -- Remote UNIX connection [Apr 6 13:40:01] VERBOSE[5704] asterisk.c: -- Remote UNIX connection disconnected [Apr 6 13:41:02] DTMF[5682] channel.c: DTMF begin '*' received on SIP/server2_ecs-00000184 [Apr 6 13:41:02] DTMF[5682] channel.c: DTMF begin passthrough '*' on SIP/server2_ecs-00000184 [Apr 6 13:41:02] DTMF[5679] channel.c: DTMF begin '*' received on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:02] DTMF[5679] channel.c: DTMF begin passthrough '*' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:03] DTMF[5682] channel.c: DTMF end '*' received on SIP/server2_ecs-00000184, duration 130 ms [Apr 6 13:41:03] DTMF[5682] channel.c: DTMF end accepted with begin '*' on SIP/server2_ecs-00000184 [Apr 6 13:41:03] DTMF[5682] channel.c: DTMF end passthrough '*' on SIP/server2_ecs-00000184 [Apr 6 13:41:03] DTMF[5679] channel.c: DTMF end '*' received on Local/300@from-queue-lookup-70fb;1, duration 130 ms [Apr 6 13:41:03] DTMF[5679] channel.c: DTMF end accepted with begin '*' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:03] DTMF[5679] channel.c: DTMF end passthrough '*' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF begin '*' received on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF begin passthrough '*' on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF begin '*' received on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF begin passthrough '*' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF end '*' received on SIP/server2_ecs-00000184, duration 128 ms [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF end accepted with begin '*' on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF end passthrough '*' on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF end '*' received on Local/300@from-queue-lookup-70fb;1, duration 128 ms [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF end accepted with begin '*' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF end passthrough '*' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF begin '2' received on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF begin passthrough '2' on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF begin '2' received on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF begin passthrough '2' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF end '2' received on SIP/server2_ecs-00000184, duration 148 ms [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF end accepted with begin '2' on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5682] channel.c: DTMF end passthrough '2' on SIP/server2_ecs-00000184 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF end '2' received on Local/300@from-queue-lookup-70fb;1, duration 148 ms [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF end accepted with begin '2' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] DTMF[5679] channel.c: DTMF end passthrough '2' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:08] VERBOSE[5679] res_musiconhold.c: -- Started music on hold, class 'Coldplay', on SIP/server2_ecs-00000183 [Apr 6 13:41:08] VERBOSE[5679] file.c: -- Playing 'pbx-transfer.alaw' (language 'nl') [Apr 6 13:41:10] DTMF[5682] channel.c: DTMF begin '9' received on SIP/server2_ecs-00000184 [Apr 6 13:41:10] DTMF[5682] channel.c: DTMF begin passthrough '9' on SIP/server2_ecs-00000184 [Apr 6 13:41:10] DTMF[5679] channel.c: DTMF begin '9' received on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:10] DTMF[5679] channel.c: DTMF begin ignored '9' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:10] DTMF[5682] channel.c: DTMF end '9' received on SIP/server2_ecs-00000184, duration 98 ms [Apr 6 13:41:10] DTMF[5682] channel.c: DTMF end accepted with begin '9' on SIP/server2_ecs-00000184 [Apr 6 13:41:10] DTMF[5682] channel.c: DTMF end passthrough '9' on SIP/server2_ecs-00000184 [Apr 6 13:41:10] DTMF[5679] channel.c: DTMF end '9' received on Local/300@from-queue-lookup-70fb;1, duration 98 ms [Apr 6 13:41:10] DTMF[5679] channel.c: DTMF end passthrough '9' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:10] DTMF[5682] channel.c: DTMF begin '0' received on SIP/server2_ecs-00000184 [Apr 6 13:41:10] DTMF[5682] channel.c: DTMF begin passthrough '0' on SIP/server2_ecs-00000184 [Apr 6 13:41:10] DTMF[5679] channel.c: DTMF begin '0' received on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:10] DTMF[5679] channel.c: DTMF begin ignored '0' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF end '0' received on SIP/server2_ecs-00000184, duration 108 ms [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF end accepted with begin '0' on SIP/server2_ecs-00000184 [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF end passthrough '0' on SIP/server2_ecs-00000184 [Apr 6 13:41:11] DTMF[5679] channel.c: DTMF end '0' received on Local/300@from-queue-lookup-70fb;1, duration 108 ms [Apr 6 13:41:11] DTMF[5679] channel.c: DTMF end passthrough '0' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF begin '1' received on SIP/server2_ecs-00000184 [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF begin passthrough '1' on SIP/server2_ecs-00000184 [Apr 6 13:41:11] DTMF[5679] channel.c: DTMF begin '1' received on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:11] DTMF[5679] channel.c: DTMF begin ignored '1' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF end '1' received on SIP/server2_ecs-00000184, duration 128 ms [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF end accepted with begin '1' on SIP/server2_ecs-00000184 [Apr 6 13:41:11] DTMF[5682] channel.c: DTMF end passthrough '1' on SIP/server2_ecs-00000184 [Apr 6 13:41:11] DTMF[5679] channel.c: DTMF end '1' received on Local/300@from-queue-lookup-70fb;1, duration 128 ms [Apr 6 13:41:11] DTMF[5679] channel.c: DTMF end passthrough '1' on Local/300@from-queue-lookup-70fb;1 [Apr 6 13:41:14] VERBOSE[5713] pbx.c: -- Executing [901@agent-xfer:1] GotoIf("Local/901@agent-xfer-6287;2", "0?agent-blind-xfer,901,1") in new stack [Apr 6 13:41:14] VERBOSE[5713] pbx.c: -- Executing [901@agent-xfer:2] NoOp("Local/901@agent-xfer-6287;2", "Agent attendant transfer to 901") in new stack [Apr 6 13:41:14] VERBOSE[5713] pbx.c: -- Executing [901@agent-xfer:3] Set("Local/901@agent-xfer-6287;2", "_QUEUE_PRIO=10") in new stack [Apr 6 13:41:14] VERBOSE[5713] pbx.c: -- Executing [901@agent-xfer:4] Dial("Local/901@agent-xfer-6287;2", "Local/901@from-internal,60,g") in new stack [Apr 6 13:41:14] VERBOSE[5713] app_dial.c: -- Called Local/901@from-internal [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:1] Macro("Local/901@from-internal-168a;2", "user-callerid,") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:1] Set("Local/901@from-internal-168a;2", "AMPUSER=900") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("Local/901@from-internal-168a;2", "1?report") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Goto (macro-user-callerid,s,11) [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:11] GotoIf("Local/901@from-internal-168a;2", "0?continue") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:12] Set("Local/901@from-internal-168a;2", "__TTL=63") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:13] GotoIf("Local/901@from-internal-168a;2", "1?continue") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Goto (macro-user-callerid,s,24) [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:24] Set("Local/901@from-internal-168a;2", "CALLERID(number)=900") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:25] Set("Local/901@from-internal-168a;2", "CALLERID(name)=") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-user-callerid:26] Set("Local/901@from-internal-168a;2", "CHANNEL(language)=nl") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:2] Answer("Local/901@from-internal-168a;2", "") in new stack [Apr 6 13:41:14] VERBOSE[5713] app_dial.c: -- Local/901@from-internal-168a;1 answered Local/901@agent-xfer-6287;2 [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:3] Macro("Local/901@from-internal-168a;2", "blkvm-set,reset") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-blkvm-set:1] ExecIf("Local/901@from-internal-168a;2", "0?Set(__BLKVM_CHANNEL=Local/901@from-internal-168a;2)") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-blkvm-set:2] Set("Local/901@from-internal-168a;2", "SHARED(BLKVM,SIP/server2_ecs-00000183)=TRUE") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-blkvm-set:3] Set("Local/901@from-internal-168a;2", "GOSUB_RETVAL=TRUE") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-blkvm-set:4] MacroExit("Local/901@from-internal-168a;2", "") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:4] ExecIf("Local/901@from-internal-168a;2", "1?Set(_DIAL_OPTIONS=trM(auto-blkvm))") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:5] Set("Local/901@from-internal-168a;2", "__NODEST=901") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:6] Set("Local/901@from-internal-168a;2", "MONITOR_FILENAME=/var/spool/asterisk/monitor/20120406/q901-20120406-134114-1333712474.124800") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:7] Set("Local/901@from-internal-168a;2", "__CWIGNORE=TRUE") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:8] Macro("Local/901@from-internal-168a;2", "agent-integration,") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:1] NoOp("Local/901@from-internal-168a;2", "Agent module integration") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:2] Set("Local/901@from-internal-168a;2", "__monitorFilename=/var/spool/asterisk/monitor/20120406/q901-20120406-134114-1333712474.124800") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:3] Set("Local/901@from-internal-168a;2", "__queueEntered=1333712474") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:4] Set("Local/901@from-internal-168a;2", "__queueUniqueId=1333712474.124800") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:5] Set("Local/901@from-internal-168a;2", "__queueId=901") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:6] Set("Local/901@from-internal-168a;2", "__TRANSFER_CONTEXT=agent-xfer") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:7] AGI("Local/901@from-internal-168a;2", "agent-url.php,901") in new stack [Apr 6 13:41:14] VERBOSE[5714] res_agi.c: -- Launched AGI Script /usr/share/asterisk/agi-bin/agent-url.php [Apr 6 13:41:14] VERBOSE[5714] res_agi.c: agent-url.php,901: No section for queue '901' in /etc/asterisk/queues_cti.conf, using 'default' [Apr 6 13:41:14] VERBOSE[5714] res_agi.c: agent-url.php,901: Set queue url to: http://crm-server/lookup?agent=[A]&queue=901&uniqueid=[U] [Apr 6 13:41:14] VERBOSE[5714] res_agi.c: -- AGI Script agent-url.php completed, returning 0 [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [s@macro-agent-integration:8] MacroExit("Local/901@from-internal-168a;2", "") in new stack [Apr 6 13:41:14] VERBOSE[5714] pbx.c: -- Executing [901@from-internal:9] Queue("Local/901@from-internal-168a;2", "901,t,http://crm-server/lookup?agent=[A]&queue=901&uniqueid=[U],") in new stack [Apr 6 13:41:14] VERBOSE[5714] res_musiconhold.c: -- Started music on hold, class 'default', on Local/901@from-internal-168a;2 [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:1] Set("Local/301@from-queue-lookup-7962;2", "_agentId=301") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:2] Set("Local/301@from-queue-lookup-7962;2", "_queueId=901") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:3] Set("Local/301@from-queue-lookup-7962;2", "_agentChan=Local/301@from-queue-lookup/n") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:4] Set("Local/301@from-queue-lookup-7962;2", "_queueCli=900") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:5] AGI("Local/301@from-queue-lookup-7962;2", "agent-lookup.php,301") in new stack [Apr 6 13:41:14] VERBOSE[5717] res_agi.c: -- Launched AGI Script /usr/share/asterisk/agi-bin/agent-lookup.php [Apr 6 13:41:14] VERBOSE[5720] manager.c: == Manager 'phpagi' logged on from 127.0.0.1 [Apr 6 13:41:14] VERBOSE[5717] res_agi.c: agent-lookup.php,301: Lookup agent 301 [Apr 6 13:41:14] VERBOSE[5717] res_agi.c: agent-lookup.php,301: Agent 301 exists [Apr 6 13:41:14] VERBOSE[5717] res_agi.c: agent-lookup.php,301: Agent 301 is at extension '201' [Apr 6 13:41:14] VERBOSE[5717] res_agi.c: agent-lookup.php,301: Agents language is 'nl' [Apr 6 13:41:14] VERBOSE[5720] manager.c: == Manager 'phpagi' logged off from 127.0.0.1 [Apr 6 13:41:14] VERBOSE[5717] res_agi.c: -- AGI Script agent-lookup.php completed, returning 0 [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:6] GotoIf("Local/301@from-queue-lookup-7962;2", "0?hangup") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:7] GotoIf("Local/301@from-queue-lookup-7962;2", "0?noaa") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:8] SIPAddHeader("Local/301@from-queue-lookup-7962;2", "Alert-Info: Auto Answer") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:9] SIPAddHeader("Local/301@from-queue-lookup-7962;2", "Call-Info: \; Answer-After=0") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:10] Set("Local/301@from-queue-lookup-7962;2", "__SPYGROUP=Agent/301") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:11] ExecIf("Local/301@from-queue-lookup-7962;2", "1?Macro(queuelog,901,1333712474.124800,Local/301@from-queue-lookup/n,AGENTATTEMPT)") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [s@macro-queuelog:1] QueueLog("Local/301@from-queue-lookup-7962;2", "901,1333712474.124800,Local/301@from-queue-lookup/n,AGENTATTEMPT,||||") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [s@macro-queuelog:2] MacroExit("Local/301@from-queue-lookup-7962;2", "") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:12] Set("Local/301@from-queue-lookup-7962;2", "completedBy=caller") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:13] ExecIf("Local/301@from-queue-lookup-7962;2", "0?Agi()") in new stack [Apr 6 13:41:14] VERBOSE[5717] pbx.c: -- Executing [301@from-queue-lookup:14] Dial("Local/301@from-queue-lookup-7962;2", "Local/201@agent-dial,60,grM(agent-answered^Local/301@from-queue-lookup-7962;2)") in new stack [Apr 6 13:41:14] VERBOSE[5717] app_dial.c: -- Called Local/201@agent-dial [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@agent-dial:1] NoCDR("Local/201@agent-dial-c4c8;2", "") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@agent-dial:2] Goto("Local/201@agent-dial-c4c8;2", "from-internal,201,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (from-internal,201,1) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@from-internal:1] Macro("Local/201@agent-dial-c4c8;2", "user-callerid,LIMIT,") in new stack [Apr 6 13:41:14] VERBOSE[5714] app_queue.c: -- Local/301@from-queue-lookup-7962;1 is ringing [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-user-callerid:1] Set("Local/201@agent-dial-c4c8;2", "AMPUSER=900") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("Local/201@agent-dial-c4c8;2", "1?report") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-user-callerid,s,11) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-user-callerid:11] GotoIf("Local/201@agent-dial-c4c8;2", "1?continue") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-user-callerid,s,24) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-user-callerid:24] Set("Local/201@agent-dial-c4c8;2", "CALLERID(number)=900") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-user-callerid:25] Set("Local/201@agent-dial-c4c8;2", "CALLERID(name)=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-user-callerid:26] Set("Local/201@agent-dial-c4c8;2", "CHANNEL(language)=nl") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@from-internal:2] Set("Local/201@agent-dial-c4c8;2", "MOHCLASS=Coldplay") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@from-internal:3] Set("Local/201@agent-dial-c4c8;2", "_NODEST=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@from-internal:4] Macro("Local/201@agent-dial-c4c8;2", "record-enable,900,OUT,") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-record-enable:1] GotoIf("Local/201@agent-dial-c4c8;2", "1?check") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-record-enable,s,4) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-record-enable:4] ExecIf("Local/201@agent-dial-c4c8;2", "0?MacroExit()") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-record-enable:5] GotoIf("Local/201@agent-dial-c4c8;2", "0?Group:OUT") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-record-enable,s,14) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-record-enable:14] GotoIf("Local/201@agent-dial-c4c8;2", "0?IN") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-record-enable:15] ExecIf("Local/201@agent-dial-c4c8;2", "1?MacroExit()") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@from-internal:5] Macro("Local/201@agent-dial-c4c8;2", "dialout-trunk,2,201,") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("Local/201@agent-dial-c4c8;2", "DIAL_TRUNK=2") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("Local/201@agent-dial-c4c8;2", "0?sub-pincheck,s,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("Local/201@agent-dial-c4c8;2", "0?disabletrunk,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("Local/201@agent-dial-c4c8;2", "DIAL_NUMBER=201") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("Local/201@agent-dial-c4c8;2", "DIAL_TRUNK_OPTIONS=tr") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("Local/201@agent-dial-c4c8;2", "OUTBOUND_GROUP=OUT_2") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("Local/201@agent-dial-c4c8;2", "1?nomax") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-dialout-trunk,s,9) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("Local/201@agent-dial-c4c8;2", "0?skipoutcid") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("Local/201@agent-dial-c4c8;2", "DIAL_TRUNK_OPTIONS=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("Local/201@agent-dial-c4c8;2", "outbound-callerid,2") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("Local/201@agent-dial-c4c8;2", "1?Set(CALLERPRES()=allowed_not_screened)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("Local/201@agent-dial-c4c8;2", "1?Set(REALCALLERIDNUM=900)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("Local/201@agent-dial-c4c8;2", "1?normcid") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-outbound-callerid,s,6) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("Local/201@agent-dial-c4c8;2", "USEROUTCID=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("Local/201@agent-dial-c4c8;2", "EMERGENCYCID=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("Local/201@agent-dial-c4c8;2", "TRUNKOUTCID=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("Local/201@agent-dial-c4c8;2", "1?trunkcid") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-outbound-callerid,s,12) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("Local/201@agent-dial-c4c8;2", "0?sub-flp-2,s,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("Local/201@agent-dial-c4c8;2", "OUTNUM=201") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("Local/201@agent-dial-c4c8;2", "custom=SIP/server1_ecs") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("Local/201@agent-dial-c4c8;2", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay))") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay)M(confirm))") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:17] Macro("Local/201@agent-dial-c4c8;2", "dialout-trunk-predial-hook,") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("Local/201@agent-dial-c4c8;2", "") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("Local/201@agent-dial-c4c8;2", "0?bypass,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:19] GotoIf("Local/201@agent-dial-c4c8;2", "0?customtrunk") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:20] Dial("Local/201@agent-dial-c4c8;2", "SIP/server1_ecs/201,300,M(setmusic^Coldplay)") in new stack [Apr 6 13:41:14] WARNING[5721] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Unknown) [Apr 6 13:41:14] VERBOSE[5721] app_dial.c: == Everyone is busy/congested at this time (1:0/0/1) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:21] NoOp("Local/201@agent-dial-c4c8;2", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 20") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:22] Goto("Local/201@agent-dial-c4c8;2", "s-CHANUNAVAIL,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-dialout-trunk,s-CHANUNAVAIL,1) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s-CHANUNAVAIL@macro-dialout-trunk:1] Set("Local/201@agent-dial-c4c8;2", "RC=20") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s-CHANUNAVAIL@macro-dialout-trunk:2] Goto("Local/201@agent-dial-c4c8;2", "20,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-dialout-trunk,20,1) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [20@macro-dialout-trunk:1] Goto("Local/201@agent-dial-c4c8;2", "continue,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-dialout-trunk,continue,1) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [continue@macro-dialout-trunk:1] GotoIf("Local/201@agent-dial-c4c8;2", "1?noreport") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-dialout-trunk,continue,3) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [continue@macro-dialout-trunk:3] NoOp("Local/201@agent-dial-c4c8;2", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 20 - failing through to other trunks") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [continue@macro-dialout-trunk:4] Set("Local/201@agent-dial-c4c8;2", "CALLERID(number)=900") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [201@from-internal:6] Macro("Local/201@agent-dial-c4c8;2", "dialout-trunk,1,201,") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("Local/201@agent-dial-c4c8;2", "DIAL_TRUNK=1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("Local/201@agent-dial-c4c8;2", "0?sub-pincheck,s,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("Local/201@agent-dial-c4c8;2", "0?disabletrunk,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("Local/201@agent-dial-c4c8;2", "DIAL_NUMBER=201") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("Local/201@agent-dial-c4c8;2", "DIAL_TRUNK_OPTIONS=tr") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("Local/201@agent-dial-c4c8;2", "OUTBOUND_GROUP=OUT_1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("Local/201@agent-dial-c4c8;2", "1?nomax") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-dialout-trunk,s,9) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("Local/201@agent-dial-c4c8;2", "0?skipoutcid") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("Local/201@agent-dial-c4c8;2", "DIAL_TRUNK_OPTIONS=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("Local/201@agent-dial-c4c8;2", "outbound-callerid,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("Local/201@agent-dial-c4c8;2", "1?Set(CALLERPRES()=allowed_not_screened)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(REALCALLERIDNUM=900)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("Local/201@agent-dial-c4c8;2", "1?normcid") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-outbound-callerid,s,6) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("Local/201@agent-dial-c4c8;2", "USEROUTCID=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("Local/201@agent-dial-c4c8;2", "EMERGENCYCID=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("Local/201@agent-dial-c4c8;2", "TRUNKOUTCID=") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("Local/201@agent-dial-c4c8;2", "1?trunkcid") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Goto (macro-outbound-callerid,s,12) [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:12] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:13] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERID(all)=)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("Local/201@agent-dial-c4c8;2", "0?sub-flp-1,s,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("Local/201@agent-dial-c4c8;2", "OUTNUM=201") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("Local/201@agent-dial-c4c8;2", "custom=SIP/server2_ecs") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("Local/201@agent-dial-c4c8;2", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay))") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("Local/201@agent-dial-c4c8;2", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^Coldplay)M(confirm))") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:17] Macro("Local/201@agent-dial-c4c8;2", "dialout-trunk-predial-hook,") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("Local/201@agent-dial-c4c8;2", "") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("Local/201@agent-dial-c4c8;2", "0?bypass,1") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:19] GotoIf("Local/201@agent-dial-c4c8;2", "0?customtrunk") in new stack [Apr 6 13:41:14] VERBOSE[5721] pbx.c: -- Executing [s@macro-dialout-trunk:20] Dial("Local/201@agent-dial-c4c8;2", "SIP/server2_ecs/201,300,M(setmusic^Coldplay)") in new stack [Apr 6 13:41:14] VERBOSE[5721] netsock2.c: == Using SIP RTP TOS bits 184 [Apr 6 13:41:14] VERBOSE[5721] netsock2.c: == Using SIP RTP CoS mark 5 [Apr 6 13:41:14] VERBOSE[5721] app_dial.c: -- Called SIP/server2_ecs/201 [Apr 6 13:41:15] VERBOSE[5721] app_dial.c: -- SIP/server2_ecs-00000185 answered Local/201@agent-dial-c4c8;2 [Apr 6 13:41:15] VERBOSE[5721] pbx.c: -- Executing [s@macro-setmusic:1] Set("SIP/server2_ecs-00000185", "CHANNEL(musicclass)=Coldplay") in new stack [Apr 6 13:41:15] VERBOSE[5717] app_dial.c: -- Local/201@agent-dial-c4c8;1 answered Local/301@from-queue-lookup-7962;2 [Apr 6 13:41:15] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-answered:1] NoOp("Local/201@agent-dial-c4c8;1", "Agent 301 answered call for queue 901") in new stack [Apr 6 13:41:15] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-answered:2] ExecIf("Local/201@agent-dial-c4c8;1", "0?Agi()") in new stack [Apr 6 13:41:15] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-answered:3] MacroExit("Local/201@agent-dial-c4c8;1", "") in new stack [Apr 6 13:41:15] VERBOSE[5714] app_queue.c: -- Local/301@from-queue-lookup-7962;1 answered Local/901@from-internal-168a;2 for queue (901) [Apr 6 13:41:15] VERBOSE[5714] res_musiconhold.c: -- Stopped music on hold on Local/901@from-internal-168a;2 [Apr 6 13:41:15] VERBOSE[5721] pbx.c: -- Executing [h@macro-dialout-trunk:1] Macro("Local/201@agent-dial-c4c8;2", "hangupcall,") in new stack [Apr 6 13:41:15] VERBOSE[5721] pbx.c: -- Executing [s@macro-hangupcall:1] GotoIf("Local/201@agent-dial-c4c8;2", "1?theend") in new stack [Apr 6 13:41:15] VERBOSE[5721] pbx.c: -- Goto (macro-hangupcall,s,3) [Apr 6 13:41:15] VERBOSE[5721] pbx.c: -- Executing [s@macro-hangupcall:3] Hangup("Local/201@agent-dial-c4c8;2", "") in new stack [Apr 6 13:41:15] VERBOSE[5721] app_macro.c: == Spawn extension (macro-hangupcall, s, 3) exited non-zero on 'Local/201@agent-dial-c4c8;2' in macro 'hangupcall' [Apr 6 13:41:15] VERBOSE[5721] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'Local/201@agent-dial-c4c8;2' [Apr 6 13:41:15] VERBOSE[5721] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on 'Local/201@agent-dial-c4c8;2' in macro 'dialout-trunk' [Apr 6 13:41:15] VERBOSE[5721] pbx.c: == Spawn extension (from-internal, 201, 6) exited non-zero on 'Local/201@agent-dial-c4c8;2' [Apr 6 13:41:15] VERBOSE[5714] pbx.c: -- Executing [h@from-internal:1] Hangup("Local/901@from-internal-168a;2", "") in new stack [Apr 6 13:41:15] VERBOSE[5714] features.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'Local/901@from-internal-168a;2' [Apr 6 13:41:15] VERBOSE[5714] pbx.c: == Spawn extension (from-internal, 901, 9) exited non-zero on 'Local/901@from-internal-168a;2' [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:15] Set("Local/300@from-queue-lookup-70fb;2", "completedBy=agent") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [300@from-queue-lookup:16] Hangup("Local/300@from-queue-lookup-70fb;2", "") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: == Spawn extension (from-queue-lookup, 300, 16) exited non-zero on 'Local/300@from-queue-lookup-70fb;2' [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [h@from-queue-lookup:1] ExecIf("Local/300@from-queue-lookup-70fb;2", "1?Macro(agent-cleanup)") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-cleanup:1] NoOp("Local/300@from-queue-lookup-70fb;2", "Call completed, cleanup") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-cleanup:2] ExecIf("Local/300@from-queue-lookup-70fb;2", "0?Agi()") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-cleanup:3] GotoIf("Local/300@from-queue-lookup-70fb;2", "0?no_monitor") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-cleanup:4] System("Local/300@from-queue-lookup-70fb;2", "test -e /var/spool/asterisk/monitor/20120406/q900-20120406-133927-1333712367.124791.*") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-cleanup:5] GotoIf("Local/300@from-queue-lookup-70fb;2", "1?no_monitor") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Goto (macro-agent-cleanup,s,9) [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-cleanup:9] NoOp("Local/300@from-queue-lookup-70fb;2", "Agent cleanup done") in new stack [Apr 6 13:41:19] VERBOSE[5682] pbx.c: -- Executing [s@macro-agent-cleanup:10] MacroExit("Local/300@from-queue-lookup-70fb;2", "") in new stack [Apr 6 13:41:19] VERBOSE[5679] pbx.c: -- Executing [h@from-queue-lookup:1] ExecIf("Local/300@from-queue-lookup-70fb;1", "0?Macro(agent-cleanup)") in new stack [Apr 6 13:41:19] VERBOSE[5679] res_musiconhold.c: -- Stopped music on hold on SIP/server2_ecs-00000183 [Apr 6 13:41:19] VERBOSE[5679] file.c: -- Playing 'beep.slin' (language 'nl') [Apr 6 13:41:19] VERBOSE[5679] pbx.c: -- Executing [h@from-internal:1] Hangup("Transfered/SIP/server2_ecs-00000183", "") in new stack [Apr 6 13:41:19] VERBOSE[5679] features.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'Transfered/SIP/server2_ecs-00000183' [Apr 6 13:41:19] VERBOSE[5679] pbx.c: == Spawn extension (from-internal, 900, 11) exited non-zero on 'Transfered/SIP/server2_ecs-00000183' [Apr 6 13:42:24] VERBOSE[5723] pbx.c: -- Executing [h@from-internal:1] Hangup("SIP/server2_ecs-00000183", "") in new stack [Apr 6 13:42:24] VERBOSE[5723] features.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/server2_ecs-00000183' [Apr 6 13:42:24] VERBOSE[5713] pbx.c: == Spawn extension (agent-xfer, 901, 4) exited non-zero on 'Local/901@agent-xfer-6287;2' [Apr 6 13:42:24] VERBOSE[5717] pbx.c: == Spawn extension (from-queue-lookup, 301, 14) exited non-zero on 'Local/301@from-queue-lookup-7962;2' [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [h@from-queue-lookup:1] ExecIf("Local/301@from-queue-lookup-7962;2", "1?Macro(agent-cleanup)") in new stack [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-cleanup:1] NoOp("Local/301@from-queue-lookup-7962;2", "Call completed, cleanup") in new stack [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-cleanup:2] ExecIf("Local/301@from-queue-lookup-7962;2", "0?Agi()") in new stack [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-cleanup:3] GotoIf("Local/301@from-queue-lookup-7962;2", "0?no_monitor") in new stack [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-cleanup:4] System("Local/301@from-queue-lookup-7962;2", "test -e /var/spool/asterisk/monitor/20120406/q901-20120406-134114-1333712474.124800.*") in new stack [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-cleanup:5] GotoIf("Local/301@from-queue-lookup-7962;2", "1?no_monitor") in new stack [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Goto (macro-agent-cleanup,s,9) [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-cleanup:9] NoOp("Local/301@from-queue-lookup-7962;2", "Agent cleanup done") in new stack [Apr 6 13:42:24] VERBOSE[5717] pbx.c: -- Executing [s@macro-agent-cleanup:10] MacroExit("Local/301@from-queue-lookup-7962;2", "") in new stack