[2011-01-20 10:10:12] -- Accepting call from '5555552301' to '6010' on channel 0/23, span 1 [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:1] Set("Zap/23-1", "__INCOMING_DNIS=6010") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:2] Set("Zap/23-1", "LINE_TENANT=default") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:3] Set("Zap/23-1", "LINE_LANGUAGE=en") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:4] Set("Zap/23-1", "LINE_CLID_NUM=0000000000") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:5] Set("Zap/23-1", "LINE_CLID_NAME=") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:6] Set("Zap/23-1", "LINE_CLID_NUM_DEF=95555552301") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:7] Set("Zap/23-1", "LINE_CLID_NAME_DEF=David Brillert:BCM502301") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:8] Set("Zap/23-1", "LINE_MOH=default") in new stack [2011-01-20 10:10:12] -- Executing [6010@zap-incoming:9] Gosub("Zap/23-1", "all-incoming-check|s|1") in new stack [2011-01-20 10:10:12] -- Executing [s@all-incoming-check:1] NoOp("Zap/23-1", ""INCOMING CALL FROM CALLER ID: 5555552301 (BCM502301)"") in new stack [2011-01-20 10:10:12] -- Executing [s@all-incoming-check:2] GotoIf("Zap/23-1", "1?7") in new stack [2011-01-20 10:10:12] -- Goto (all-incoming-check,s,7) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:7] GotoIf("Zap/23-1", "1?10") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,10) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:10] GotoIf("Zap/23-1", "1?12") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,12) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:12] GotoIf("Zap/23-1", "1?14") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,14) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:14] GotoIf("Zap/23-1", "1?16") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,16) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:16] GotoIf("Zap/23-1", "0?18") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:17] Set("Zap/23-1", "CHANNEL(musicclass)=default") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:18] Set("Zap/23-1", "CALLERID(dnid)=6010") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:19] Set("Zap/23-1", "CDR(userfield)=6010") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:20] Set("Zap/23-1", "__EXTCONTEXT=default-default") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:21] Set("Zap/23-1", "__INCOMINGLINE=1") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:22] Set("Zap/23-1", "__ORGCALLID=1295536212.55") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:23] GotoIf("Zap/23-1", "1?25") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,25) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:25] GotoIf("Zap/23-1", "1?27") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,27) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:27] GotoIf("Zap/23-1", "1?29") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,29) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:29] GotoIf("Zap/23-1", "1?31") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,31) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:31] AGI("Zap/23-1", "agi://127.0.0.1:4573/fixcidname") in new stack [2011-01-20 10:10:13] -- AGI Script agi://127.0.0.1:4573/fixcidname completed, returning 0 [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:32] GotoIf("Zap/23-1", "1?34") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,34) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:34] GotoIf("Zap/23-1", "0?36") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:35] Set("Zap/23-1", "CHANNEL(language)=en") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:36] Set("Zap/23-1", "FAXNUMBER=6010") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:37] GotoIf("Zap/23-1", "1?39") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,39) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:39] GotoIf("Zap/23-1", "1?41") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,41) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:41] GotoIf("Zap/23-1", "1?44") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,44) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:44] GotoIf("Zap/23-1", "0?49") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:45] GotoIf("Zap/23-1", "1?47") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,47) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:47] GotoIf("Zap/23-1", "1?49") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,49) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:49] GotoIf("Zap/23-1", "1?54") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,54) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:54] GotoIf("Zap/23-1", "0?56") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:55] Set("Zap/23-1", "CALLERID(number)=95555552301") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:56] GotoIf("Zap/23-1", "0?58") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:57] Set("Zap/23-1", "CALLERID(name)=David Brillert:BCM502301") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:58] GotoIf("Zap/23-1", "1?60") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,60) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:60] GotoIf("Zap/23-1", "1?62") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,62) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:62] Set("Zap/23-1", "CALLFILENAME=1295536212.55") in new stack [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:63] GotoIf("Zap/23-1", "1?65") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,65) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:65] GotoIf("Zap/23-1", "1?67") in new stack [2011-01-20 10:10:13] -- Goto (all-incoming-check,s,67) [2011-01-20 10:10:13] -- Executing [s@all-incoming-check:67] Return("Zap/23-1", "") in new stack [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:10] Answer("Zap/23-1", "") in new stack [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:11] Goto("Zap/23-1", "20") in new stack [2011-01-20 10:10:13] -- Goto (zap-incoming,6010,20) [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:20] GotoIf("Zap/23-1", "0?23") in new stack [2011-01-20 10:10:13] NOTICE[8610]: res_odbc.c:529 odbc_obj_connect: Re-connecting scopserv [2011-01-20 10:10:13] NOTICE[8610]: res_odbc.c:559 odbc_obj_connect: res_odbc: Connected to scopserv [scopserv] [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:21] GotoIf("Zap/23-1", "0?22:23") in new stack [2011-01-20 10:10:13] -- Goto (zap-incoming,6010,23) [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:23] GotoIf("Zap/23-1", "0?25") in new stack [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:24] GotoIf("Zap/23-1", "0?all-blacklisted|s|1") in new stack [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:25] Set("Zap/23-1", "__CALLDIVERT=YES") in new stack [2011-01-20 10:10:13] -- Executing [6010@zap-incoming:26] Dial("Zap/23-1", "Local/6010@default-local/n|") in new stack [2011-01-20 10:10:13] -- Called 6010@default-local/n [2011-01-20 10:10:13] -- Executing [6010@default-local:1] Set("Local/6010@default-local-4f38,2", "LOCAL_EXTEN=6010") in new stack [2011-01-20 10:10:13] -- Executing [6010@default-local:2] Set("Local/6010@default-local-4f38,2", "LOCAL_LIMIT=1") in new stack [2011-01-20 10:10:13] -- Executing [6010@default-local:3] Gosub("Local/6010@default-local-4f38,2", "all-local-extension|s|1") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:1] Set("Local/6010@default-local-4f38,2", "__PICKUPMARK=6010") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:2] GotoIf("Local/6010@default-local-4f38,2", "0?4") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:3] Set("Local/6010@default-local-4f38,2", "GROUP(OUTGOING)=95555552301") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:4] Set("Local/6010@default-local-4f38,2", "OUTBOUND_GROUP_ONCE=6010@INCOMING") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:5] GotoIf("Local/6010@default-local-4f38,2", "0?8") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:6] Set("Local/6010@default-local-4f38,2", "GROUPCOUNT=0") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:7] Set("Local/6010@default-local-4f38,2", "GROUPCOUNT2=0") in new stack [2011-01-20 10:10:13] -- Executing [s@all-local-extension:8] Return("Local/6010@default-local-4f38,2", "") in new stack [2011-01-20 10:10:13] -- Executing [6010@default-local:4] Set("Local/6010@default-local-4f38,2", "SCOPSERV_DBPUT(default/wrapup/6010/lastcall)=1295536213.57") in new stack [2011-01-20 10:10:13] -- Executing [6010@default-local:5] Macro("Local/6010@default-local-4f38,2", "default-dial|SIP/6010|6010|default|20|en|b6010@default|tkK||default||Local/s@default-aa-operator-6010|disa") in new stack [2011-01-20 10:10:13] -- Executing [s@macro-default-dial:1] NoOp("Local/6010@default-local-4f38,2", ""CALL TO LOCAL EXTENSION FROM 95555552301(David Brillert:BCM502301)"") in new stack [2011-01-20 10:10:13] -- Executing [s@macro-default-dial:2] Set("Local/6010@default-local-4f38,2", "__PICKUPMARK=6010") in new stack [2011-01-20 10:10:13] -- Executing [s@macro-default-dial:3] AGI("Local/6010@default-local-4f38,2", "agi://127.0.0.1:4573/dial") in new stack [2011-01-20 10:10:13] == Parsing '/etc/asterisk/manager.conf': [2011-01-20 10:10:13] Found [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG1' result is SIP/6010 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG2' result is 6010 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG3' result is default [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG4' result is 20 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG5' result is en [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG6' result is b6010@default [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG7' result is tkK [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG8' result is [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG9' result is default [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG10' result is [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG11' result is Local/s@default-aa-operator-6010 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'ARG12' result is disa [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'EXT_ACCODE' result is not defined!!! [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'MACRO_PRIORITY' result is 5 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'CALLBACK_ON_HANGUP' result is not defined!!! [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'CLID_BLOCK' result is not defined!!! [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'INCOMINGLINE' result is 1 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'MONITOR_OPTION' result is not defined!!! [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'AUTO_RECORDING' result is not defined!!! [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'FORCE_RECORDING' result is not defined!!! [2011-01-20 10:10:13] -- AGI Script Executing Application: (MixMonitor) Options: (default-super_1295536213.57.WAV|b) [2011-01-20 10:10:13] == Begin MixMonitor Recording Local/6010@default-local-4f38,2 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'LIMIT_IN_DEFAULT_6010' result is 8 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'GROUPCOUNT' result is 0 [2011-01-20 10:10:13] agi://127.0.0.1:4573/dial: Variable 'GROUPCOUNT2' result is 0 [2011-01-20 10:10:13] -- AGI Script Executing Application: (NoOp) Options: (STATUS:) [2011-01-20 10:10:13] -- AGI Script Executing Application: (Dial) Options: (SIP/6010|20|tkKT|) [2011-01-20 10:10:13] -- Called 6010 [2011-01-20 10:10:13] Extension Changed 6010[default-local] new state Ringing for Notify User 6001 [2011-01-20 10:10:13] Extension Changed 6010[default-local] new state Ringing for Notify User 6002 [2011-01-20 10:10:13] Extension Changed 6010[default-local] new state Ringing for Notify User 6010 [2011-01-20 10:10:13] -- SIP/6010-00000016 is ringing [2011-01-20 10:10:13] -- Local/6010@default-local-4f38,1 is ringing [2011-01-20 10:10:14] -- SIP/6010-00000016 answered Local/6010@default-local-4f38,2 [2011-01-20 10:10:14] -- Local/6010@default-local-4f38,1 stopped sounds [2011-01-20 10:10:14] -- Local/6010@default-local-4f38,1 answered Zap/23-1 [2011-01-20 10:10:14] Extension Changed 6010[default-local] new state InUse for Notify User 6001 [2011-01-20 10:10:14] Extension Changed 6010[default-local] new state InUse for Notify User 6002 [2011-01-20 10:10:14] Extension Changed 6010[default-local] new state InUse for Notify User 6010 lab*CLI> core show channels Channel Location State Application(Data) SIP/6010-00000016 (None) Up AppDial((Outgoing Line)) Local/6010@default-l s@macro-default-dial Up Dial(SIP/6010|20|tkKT|) Local/6010@default-l (None) Up AppDial((Outgoing Line)) Zap/23-1 6010@zap-incoming:26 Up Dial(Local/6010@default-local/ 4 active channels 2 of 460 max active calls ( 0.43% of capacity) [2011-01-20 10:10:19] -- Started music on hold, class 'default', on channel 'Local/6010@default-local-4f38,2' [2011-01-20 10:10:19] Extension Changed 6010[default-local] new state Hold for Notify User 6001 [2011-01-20 10:10:19] Extension Changed 6010[default-local] new state Hold for Notify User 6002 [2011-01-20 10:10:19] Extension Changed 6010[default-local] new state Hold for Notify User 6010 [2011-01-20 10:10:20] -- Executing [7000@default-super:1] Park("SIP/6010-00000017", "") in new stack [2011-01-20 10:10:22] == Parked SIP/6010-00000017 on 7001@parkedcalls. Will timeout back to extension [default-super] s, 1 in 45 seconds [2011-01-20 10:10:22] -- Added extension '7001' priority 1 to parkedcalls [2011-01-20 10:10:22] -- Playing 'digits/7' (language 'en') [2011-01-20 10:10:22] Extension Changed 7001[default-local] new state InUse for Notify User 6333 [2011-01-20 10:10:22] Extension Changed 7001[default-local] new state InUse for Notify User 6001 [2011-01-20 10:10:22] Extension Changed 7001[default-local] new state InUse for Notify User 6006 [2011-01-20 10:10:22] Extension Changed 7001[default-local] new state InUse for Notify User 6002 [2011-01-20 10:10:22] -- Playing 'digits/0' (language 'en') [2011-01-20 10:10:22] -- Stopped music on hold on Local/6010@default-local-4f38,2 [2011-01-20 10:10:22] -- Started music on hold, class 'default', on channel 'Local/6010@default-local-4f38,2' [2011-01-20 10:10:22] == Spawn extension (default-super, s, 1) exited non-zero on 'Parked/SIP/6010-00000017' [2011-01-20 10:10:22] -- Executing [h@macro-default-dial:1] ResetCDR("SIP/6010-00000017", "w") in new stack [2011-01-20 10:10:22] -- Executing [h@macro-default-dial:2] NoCDR("SIP/6010-00000017", "") in new stack [2011-01-20 10:10:22] == Spawn extension (default-local, 6010, 5) exited non-zero on 'SIP/6010-00000017' [2011-01-20 10:10:23] Extension Changed 6010[default-local] new state Idle for Notify User 6001 [2011-01-20 10:10:23] Extension Changed 6010[default-local] new state Idle for Notify User 6002 [2011-01-20 10:10:23] Extension Changed 6010[default-local] new state Idle for Notify User 6010 [2011-01-20 10:10:24] WARNING[8610]: channel.c:985 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6010@default-local-4f38,2 [2011-01-20 10:10:26] WARNING[8610]: channel.c:985 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6010@default-local-4f38,2 [2011-01-20 10:10:27] WARNING[8610]: channel.c:985 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6010@default-local-4f38,2 lab*CLI> core show channels Channel Location State Application(Data) Local/6010@default-l s@default-super:1 Up Parked Call() Local/6010@default-l (None) Up AppDial((Outgoing Line)) Zap/23-1 6010@zap-incoming:26 Up Dial(Local/6010@default-local/ 3 active channels 1 of 460 max active call ( 0.22% of capacity) [2011-01-20 10:10:28] WARNING[8610]: channel.c:985 __ast_queue_frame: Exceptionally long voice queue length queuing to Local/6010@default-local-4f38,2 [2011-01-20 10:10:29] -- Channel 0/23, span 1 got hangup request, cause 16 [2011-01-20 10:10:29] -- Executing [h@zap-incoming:1] Goto("Zap/23-1", "all-hangup|s|1") in new stack [2011-01-20 10:10:29] -- Goto (all-hangup,s,1) [2011-01-20 10:10:29] -- Executing [s@all-hangup:1] GotoIf("Zap/23-1", "0?all-faxnotify|s|1:2") in new stack [2011-01-20 10:10:29] -- Goto (all-hangup,s,2) [2011-01-20 10:10:29] -- Executing [s@all-hangup:2] ResetCDR("Zap/23-1", "w") in new stack [2011-01-20 10:10:29] -- Executing [s@all-hangup:3] NoCDR("Zap/23-1", "") in new stack [2011-01-20 10:10:29] == Spawn extension (all-hangup, 6010, 26) exited non-zero on 'Zap/23-1' [2011-01-20 10:10:29] -- Hungup 'Zap/23-1' lab*CLI> core show channels Channel Location State Application(Data) Local/6010@default-l s@default-super:1 Up Parked Call() 1 active channel 0 of 460 max active calls ( 0.00% of capacity)