Polycom 6000 conference phone is set up in a room as a regular client (i.e. same as the IP560s on all the desks). I can call out from the phone no problem. I can call the phone directly (pick up an internal phone and make a direct call to the extension). I can call conference rooms (on FreePBX) with no issues.
But if someone calls in and we try to transfer them, we can’t. It simply doesn’t transfer. Calling from my cell to the main line, and then trying to transfer to the conference phone.
[spoiler]
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: dialparties.agi: Methodology of ring is ‘ringall’
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Added extension 1000 to extension map
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Added extension 4000 to extension map
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Added extension 1005 to extension map
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Extension 1000 cf is disabled
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Extension 4000 cf is disabled
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Extension 1005 cf is disabled
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Extension 1000 do not disturb is disabled
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Extension 4000 do not disturb is disabled
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Extension 1005 do not disturb is disabled
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: dbset CALLTRACE/1000 to 3472181011
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: dbset CALLTRACE/4000 to 3472181011
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: dbset CALLTRACE/1005 to 3472181011
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – dialparties.agi: Filtered ARG3: 1000-4000-1005
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] res_agi.c: – <SIP/voipms-00001269>AGI Script dialparties.agi completed, returning 0
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-dial:7] Dial(“SIP/voipms-00001269”, “SIP/1000&SIP/4000&SIP/1005,17,trM(auto-blkvm)”) in new stack
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] netsock2.c: == Using SIP RTP TOS bits 184
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] netsock2.c: == Using SIP RTP CoS mark 5
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] netsock2.c: == Using SIP RTP TOS bits 184
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] netsock2.c: == Using SIP RTP CoS mark 5
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] netsock2.c: == Using SIP RTP TOS bits 184
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] netsock2.c: == Using SIP RTP CoS mark 5
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – Called SIP/1000
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – Called SIP/4000
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – Called SIP/1005
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/1005-0000126c connected line has changed. Saving it until answer for SIP/voipms-00001269
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/4000-0000126b connected line has changed. Saving it until answer for SIP/voipms-00001269
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/1000-0000126a connected line has changed. Saving it until answer for SIP/voipms-00001269
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/4000-0000126b is ringing
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/1000-0000126a is ringing
[2016-05-16 11:54:52] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/1005-0000126c is ringing
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/1000-0000126a connected line has changed. Saving it until answer for SIP/voipms-00001269
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] app_dial.c: – SIP/1000-0000126a answered SIP/voipms-00001269
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:1] Set(“SIP/1000-0000126a”, “__MACRO_RESULT=”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:2] Set(“SIP/1000-0000126a”, “CFIGNORE=”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:3] Set(“SIP/1000-0000126a”, “MASTER_CHANNEL(CFIGNORE)=”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:4] Set(“SIP/1000-0000126a”, “FORWARD_CONTEXT=from-internal”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:5] Set(“SIP/1000-0000126a”, “MASTER_CHANNEL(FORWARD_CONTEXT)=from-internal”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:6] Macro(“SIP/1000-0000126a”, “blkvm-clr,”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-blkvm-clr:1] Set(“SIP/1000-0000126a”, “SHARED(BLKVM,SIP/voipms-00001269)=”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-blkvm-clr:2] Set(“SIP/1000-0000126a”, “GOSUB_RETVAL=”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-blkvm-clr:3] MacroExit(“SIP/1000-0000126a”, “”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:7] ExecIf(“SIP/1000-0000126a”, “0?Set(MASTER_CHANNEL(CONNECTEDLINE(num))=1000)”) in new stack
[2016-05-16 11:54:53] VERBOSE[29904][C-0000bc83] pbx.c: – Executing [s@macro-auto-blkvm:8] ExecIf(“SIP/1000-0000126a”, “0?Set(MASTER_CHANNEL(CONNECTEDLINE(name))=Front Desk)”) in new stack
[2016-05-16 11:54:55] VERBOSE[29904][C-0000bc83] res_musiconhold.c: – Started music on hold, class ‘default’, on SIP/voipms-00001269
[2016-05-16 11:54:57] VERBOSE[31867][C-0000bc84] netsock2.c: == Using SIP RTP TOS bits 184
[2016-05-16 11:54:57] VERBOSE[31867][C-0000bc84] netsock2.c: == Using SIP RTP CoS mark 5
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [3000@from-internal:1] GotoIf(“SIP/1000-0000126d”, “1?ext-local,3000,1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (ext-local,3000,1)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [3000@ext-local:1] Set(“SIP/1000-0000126d”, “__RINGTIMER=15”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [3000@ext-local:2] Macro(“SIP/1000-0000126d”, “exten-vm,novm,3000,0,0,0”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:1] Macro(“SIP/1000-0000126d”, “user-callerid,”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/1000-0000126d”, “TOUCH_MONITOR=1463414097.97530”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:2] Set(“SIP/1000-0000126d”, “AMPUSER=1000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/1000-0000126d”, “0?report”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/1000-0000126d”, “1?Set(REALCALLERIDNUM=1000)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/1000-0000126d”, “AMPUSER=1000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:6] GotoIf(“SIP/1000-0000126d”, “0?limit”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:7] Set(“SIP/1000-0000126d”, “AMPUSERCIDNAME=Front Desk”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:8] GotoIf(“SIP/1000-0000126d”, “0?report”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:9] Set(“SIP/1000-0000126d”, “AMPUSERCID=1000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:10] Set(“SIP/1000-0000126d”, “__DIAL_OPTIONS=Ttr”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:11] Set(“SIP/1000-0000126d”, “CALLERID(all)=“Front Desk” <1000>”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:12] GotoIf(“SIP/1000-0000126d”, “0?limit”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:13] ExecIf(“SIP/1000-0000126d”, “0?Set(GROUP(concurrency_limit)=1000)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:14] GosubIf(“SIP/1000-0000126d”, “7?sub-ccss,s,1(macro-exten-vm,3000)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-ccss:1] ExecIf(“SIP/1000-0000126d”, “0?Return()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-ccss:2] Set(“SIP/1000-0000126d”, “CCSS_SETUP=TRUE”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-ccss:3] GosubIf(“SIP/1000-0000126d”, “0?monitor_config,1(macro-exten-vm,3000):monitor_default,1(macro-exten-vm,3000)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [monitor_default@sub-ccss:1] GotoIf(“SIP/1000-0000126d”, “1?is_exten”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (sub-ccss,monitor_default,4)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [monitor_default@sub-ccss:4] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(cc_monitor_policy)=generic”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [monitor_default@sub-ccss:5] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(cc_max_monitors)=5”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [monitor_default@sub-ccss:6] Return(“SIP/1000-0000126d”, “TRUE”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-ccss:4] GosubIf(“SIP/1000-0000126d”, “7?agent_config,1():agent_default,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:1] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(cc_agent_policy)=generic”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:2] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(cc_offer_timer)=30”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:3] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(ccbs_available_timer)=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:4] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(ccnr_available_timer)=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:5] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(cc_callback_macro)=ccss-default”) in new stack
[2016-05-16 11:54:57] WARNING[29909][C-0000bc84] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:6] ExecIf(“SIP/1000-0000126d”, “1?Set(CALLCOMPLETION(cc_recall_timer)=)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:7] ExecIf(“SIP/1000-0000126d”, “1?Set(CALLCOMPLETION(cc_max_agents)=)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:8] ExecIf(“SIP/1000-0000126d”, “0?Set(CALLCOMPLETION(cc_agent_dialstring)=Local/1000_3000@from-ccss-)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:9] Set(“SIP/1000-0000126d”, “CALLCOMPLETION(cc_callback_macro)=ccss-default”) in new stack
[2016-05-16 11:54:57] WARNING[29909][C-0000bc84] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead.
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [agent_config@sub-ccss:10] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-ccss:5] Set(“SIP/1000-0000126d”, “DB(AMPUSER/1000/ccss/last_number)=3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-ccss:6] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:15] ExecIf(“SIP/1000-0000126d”, “0?Set(CHANNEL(language)=)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:16] GotoIf(“SIP/1000-0000126d”, “0?continue”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:17] ExecIf(“SIP/1000-0000126d”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:18] Set(“SIP/1000-0000126d”, “__TTL=64”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:19] GotoIf(“SIP/1000-0000126d”, “1?continue”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (macro-user-callerid,s,30)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:30] Set(“SIP/1000-0000126d”, “CALLERID(number)=1000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:31] Set(“SIP/1000-0000126d”, “CALLERID(name)=Front Desk”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:32] Set(“SIP/1000-0000126d”, “CDR(cnum)=1000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:33] Set(“SIP/1000-0000126d”, “CDR(cnam)=Front Desk”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-user-callerid:34] Set(“SIP/1000-0000126d”, “CHANNEL(language)=en”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:2] Set(“SIP/1000-0000126d”, “RingGroupMethod=none”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:3] Set(“SIP/1000-0000126d”, “__EXTTOCALL=3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:4] Set(“SIP/1000-0000126d”, “__PICKUPMARK=3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:5] Set(“SIP/1000-0000126d”, “RT=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:6] ExecIf(“SIP/1000-0000126d”, “0?Macro(vm,novm,DIRECTDIAL,)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:7] ExecIf(“SIP/1000-0000126d”, “0?MacroExit()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:8] Gosub(“SIP/1000-0000126d”, “sub-record-check,s,1(exten,3000,dontcare)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:1] GotoIf(“SIP/1000-0000126d”, “0?initialized”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:2] Set(“SIP/1000-0000126d”, “__REC_STATUS=INITIALIZED”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:3] Set(“SIP/1000-0000126d”, “NOW=1463414097”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:4] Set(“SIP/1000-0000126d”, “__DAY=16”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:5] Set(“SIP/1000-0000126d”, “__MONTH=05”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:6] Set(“SIP/1000-0000126d”, “__YEAR=2016”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:7] Set(“SIP/1000-0000126d”, “__TIMESTR=20160516-115457”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:8] Set(“SIP/1000-0000126d”, “__FROMEXTEN=1000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:9] Set(“SIP/1000-0000126d”, “__MON_FMT=wav”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:10] NoOp(“SIP/1000-0000126d”, “Recordings initialized”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:11] ExecIf(“SIP/1000-0000126d”, “0?Set(ARG3=dontcare)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:12] Set(“SIP/1000-0000126d”, “REC_POLICY_MODE_SAVE=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:13] ExecIf(“SIP/1000-0000126d”, “0?Set(REC_STATUS=NO)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:14] GotoIf(“SIP/1000-0000126d”, “5?checkaction”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (sub-record-check,s,17)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-record-check:17] GotoIf(“SIP/1000-0000126d”, “1?sub-record-check,exten,1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (sub-record-check,exten,1)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:1] NoOp(“SIP/1000-0000126d”, “Exten Recording Check between 1000 and 3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:2] Set(“SIP/1000-0000126d”, “CALLTYPE=internal”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:3] ExecIf(“SIP/1000-0000126d”, “0?Set(CALLTYPE=)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:4] Set(“SIP/1000-0000126d”, “CALLEE=dontcare”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:5] ExecIf(“SIP/1000-0000126d”, “0?Set(CALLEE=dontcare)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:6] GotoIf(“SIP/1000-0000126d”, “0?callee”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:7] GotoIf(“SIP/1000-0000126d”, “1?caller”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (sub-record-check,exten,13)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:13] Set(“SIP/1000-0000126d”, “RECMODE=dontcare”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:14] ExecIf(“SIP/1000-0000126d”, “0?Set(RECMODE=dontcare)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:15] ExecIf(“SIP/1000-0000126d”, “1?Set(RECMODE=dontcare)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:16] Gosub(“SIP/1000-0000126d”, “recordcheck,1(dontcare,internal,3000)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [recordcheck@sub-record-check:1] NoOp(“SIP/1000-0000126d”, “Starting recording check against dontcare”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [recordcheck@sub-record-check:2] Goto(“SIP/1000-0000126d”, “dontcare”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (sub-record-check,recordcheck,3)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [recordcheck@sub-record-check:3] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [exten@sub-record-check:17] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:9] GotoIf(“SIP/1000-0000126d”, “1?macrodial”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (macro-exten-vm,s,15)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:15] GosubIf(“SIP/1000-0000126d”, “0?clrheader,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-exten-vm:16] Macro(“SIP/1000-0000126d”, “dial-one,Ttr,3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:1] Set(“SIP/1000-0000126d”, “DEXTEN=3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:2] Set(“SIP/1000-0000126d”, “DIALSTATUS_CW=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:3] GosubIf(“SIP/1000-0000126d”, “0?screen,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:4] GosubIf(“SIP/1000-0000126d”, “0?cf,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:5] GotoIf(“SIP/1000-0000126d”, “1?skip1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (macro-dial-one,s,8)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:8] GotoIf(“SIP/1000-0000126d”, “0?nodial”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:9] GotoIf(“SIP/1000-0000126d”, “0?continue”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:10] Set(“SIP/1000-0000126d”, “EXTHASCW=ENABLED”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:11] GotoIf(“SIP/1000-0000126d”, “0?next1:cwinusebusy”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (macro-dial-one,s,23)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:23] GotoIf(“SIP/1000-0000126d”, “1?next3:continue”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (macro-dial-one,s,24)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:24] ExecIf(“SIP/1000-0000126d”, “0?Set(DIALSTATUS_CW=BUSY)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:25] GotoIf(“SIP/1000-0000126d”, “0?nodial”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:26] GosubIf(“SIP/1000-0000126d”, “1?dstring,1():dlocal,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:1] Set(“SIP/1000-0000126d”, “DSTRING=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:2] Set(“SIP/1000-0000126d”, “DEVICES=3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:3] ExecIf(“SIP/1000-0000126d”, “0?Return()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:4] ExecIf(“SIP/1000-0000126d”, “0?Set(DEVICES=000)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:5] Set(“SIP/1000-0000126d”, “LOOPCNT=1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:6] Set(“SIP/1000-0000126d”, “ITER=1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:7] Set(“SIP/1000-0000126d”, “THISDIAL=SIP/3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:8] GosubIf(“SIP/1000-0000126d”, “1?zap2dahdi,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:1] ExecIf(“SIP/1000-0000126d”, “0?Return()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:2] Set(“SIP/1000-0000126d”, “NEWDIAL=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:3] Set(“SIP/1000-0000126d”, “LOOPCNT2=1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:4] Set(“SIP/1000-0000126d”, “ITER2=1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:5] Set(“SIP/1000-0000126d”, “THISPART2=SIP/3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:6] ExecIf(“SIP/1000-0000126d”, “0?Set(THISPART2=DAHDI/3000)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:7] Set(“SIP/1000-0000126d”, “NEWDIAL=SIP/3000&”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:8] Set(“SIP/1000-0000126d”, “ITER2=2”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:9] GotoIf(“SIP/1000-0000126d”, “0?begin2”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:10] Set(“SIP/1000-0000126d”, “THISDIAL=SIP/3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [zap2dahdi@macro-dial-one:11] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:9] GotoIf(“SIP/1000-0000126d”, “1?doset”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (macro-dial-one,dstring,13)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:13] Set(“SIP/1000-0000126d”, “DSTRING=SIP/3000&”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:14] Set(“SIP/1000-0000126d”, “ITER=2”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:15] GotoIf(“SIP/1000-0000126d”, “0?begin”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:16] ExecIf(“SIP/1000-0000126d”, “0?Return()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:17] Set(“SIP/1000-0000126d”, “DSTRING=SIP/3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [dstring@macro-dial-one:18] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:27] GotoIf(“SIP/1000-0000126d”, “0?nodial”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:28] GotoIf(“SIP/1000-0000126d”, “0?skiptrace”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:29] GosubIf(“SIP/1000-0000126d”, “1?ctset,1():ctclear,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [ctset@macro-dial-one:1] Set(“SIP/1000-0000126d”, “DB(CALLTRACE/3000)=1000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [ctset@macro-dial-one:2] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:30] Set(“SIP/1000-0000126d”, “D_OPTIONS=Ttr”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:31] ExecIf(“SIP/1000-0000126d”, “0?SIPAddHeader(Alert-Info: )”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:32] ExecIf(“SIP/1000-0000126d”, “0?SIPAddHeader()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:33] ExecIf(“SIP/1000-0000126d”, “0?Set(CHANNEL(musicclass)=)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:34] GosubIf(“SIP/1000-0000126d”, “0?qwait,1()”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:35] Set(“SIP/1000-0000126d”, “__CWIGNORE=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:36] Set(“SIP/1000-0000126d”, “__KEEPCID=TRUE”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:37] GotoIf(“SIP/1000-0000126d”, “0?usegoto,1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:38] GotoIf(“SIP/1000-0000126d”, “0?godial”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:39] Gosub(“SIP/1000-0000126d”, “sub-presencestate-display,s,1(3000)”) in new stack
[2016-05-16 11:54:57] WARNING[29909][C-0000bc84] func_presencestate.c: PRESENCE_STATE unknown
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@sub-presencestate-display:1] Goto(“SIP/1000-0000126d”, “state-,1”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Goto (sub-presencestate-display,state-,1)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [state-@sub-presencestate-display:1] Set(“SIP/1000-0000126d”, “PRESENCESTATE_DISPLAY=”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [state-@sub-presencestate-display:2] Return(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:40] Set(“SIP/1000-0000126d”, “CONNECTEDLINE(name,i)=Conf x3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:41] Set(“SIP/1000-0000126d”, “CONNECTEDLINE(num)=3000”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:42] Set(“SIP/1000-0000126d”, “D_OPTIONS=TtrI”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:43] Macro(“SIP/1000-0000126d”, “dialout-one-predial-hook,”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dialout-one-predial-hook:1] MacroExit(“SIP/1000-0000126d”, “”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:44] ExecIf(“SIP/1000-0000126d”, “0?Set(D_OPTIONS=trII)”) in new stack
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] pbx.c: – Executing [s@macro-dial-one:45] Dial(“SIP/1000-0000126d”, “SIP/3000,TtrI”) in new stack
[2016-05-16 11:54:57] WARNING[29909][C-0000bc84] app_dial.c: Unable to create channel of type ‘SIP’ (cause 20 - Subscriber absent)
[2016-05-16 11:54:57] VERBOSE[29909][C-0000bc84] app_dial.c: == Everyone is busy/congested at this time (1:0/0/1)
[\spoiler]