Handsets are dialing extensions as outside calls HELP!

Hey everyone,

I have a site that is using Polycom Handsets, the PBX is version FreePBX 2.11.0.43, I have several other sites using almost the identical setup other than the handsets, when they try to call extension to extension, it acts REALLY strange… (CLI info posted below), as in, if they lift the handset and dial extension 115, it tries to dial out to the world “15”, if they do NOT lift the handset and dial 115 and then either lift the handset or hit the “dial” button, it dials the extension fine. I’ve had them dial both ways, and a regular call to a public line to show the differences, any assistance would be greatly appreciated.

Osyrys

(begin CLI)
Lifted handset with dialtone and dial the extension

AxcessPBXCLI>
AxcessPBX
CLI>
AxcessPBX*CLI>
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [11@from-internal:1] Macro(“SIP/119-00000124”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/119-00000124”, “TOUCH_MONITOR=1434674979.292”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/119-00000124”, “AMPUSER=119”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/119-00000124”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/119-00000124”, “1?Set(REALCALLERIDNUM=119)”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/119-00000124”, “AMPUSER=119”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/119-00000124”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/119-00000124”, “AMPUSERCIDNAME=Spare”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/119-00000124”, “0?report”) in new stack
– Executing [s@macro-user-callerid:9] Set(“SIP/119-00000124”, “AMPUSERCID=119”) in new stack
– Executing [s@macro-user-callerid:10] Set(“SIP/119-00000124”, “__DIAL_OPTIONS=Ttr”) in new stack
– Executing [s@macro-user-callerid:11] Set(“SIP/119-00000124”, “CALLERID(all)=“Spare” <119>”) in new stack
– Executing [s@macro-user-callerid:12] GotoIf(“SIP/119-00000124”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:13] ExecIf(“SIP/119-00000124”, “1?Set(GROUP(concurrency_limit)=119)”) in new stack
– Executing [s@macro-user-callerid:14] GosubIf(“SIP/119-00000124”, “7?sub-ccss,s,1(from-internal,11)”) in new stack
– Executing [s@sub-ccss:1] ExecIf(“SIP/119-00000124”, “0?Return()”) in new stack
– Executing [s@sub-ccss:2] Set(“SIP/119-00000124”, “CCSS_SETUP=TRUE”) in new stack
– Executing [s@sub-ccss:3] GosubIf(“SIP/119-00000124”, “0?monitor_config,1(from-internal,11):monitor_default,1(from-internal,11)”) in

new stack
– Executing [monitor_default@sub-ccss:1] GotoIf(“SIP/119-00000124”, “0?is_exten”) in new stack
– Executing [monitor_default@sub-ccss:2] StackPop(“SIP/119-00000124”, “”) in new stack
– Executing [monitor_default@sub-ccss:3] Return(“SIP/119-00000124”, “FALSE”) in new stack
– Executing [s@macro-user-callerid:15] ExecIf(“SIP/119-00000124”, “0?Set(CHANNEL(language)=)”) in new stack
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/119-00000124”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,29)
– Executing [s@macro-user-callerid:29] Set(“SIP/119-00000124”, “CALLERID(number)=119”) in new stack
– Executing [s@macro-user-callerid:30] Set(“SIP/119-00000124”, “CALLERID(name)=Spare”) in new stack
– Executing [s@macro-user-callerid:31] Set(“SIP/119-00000124”, “CDR(cnum)=119”) in new stack
– Executing [s@macro-user-callerid:32] Set(“SIP/119-00000124”, “CDR(cnam)=Spare”) in new stack
– Executing [s@macro-user-callerid:33] Set(“SIP/119-00000124”, “CHANNEL(language)=en”) in new stack
– Executing [11@from-internal:2] Set(“SIP/119-00000124”, “MOHCLASS=default”) in new stack
– Executing [11@from-internal:3] ExecIf(“SIP/119-00000124”, “1?Set(TRUNKCIDOVERRIDE=0352296844)”) in new stack
– Executing [11@from-internal:4] Set(“SIP/119-00000124”, “_NODEST=”) in new stack
– Executing [11@from-internal:5] Gosub(“SIP/119-00000124”, “sub-record-check,s,1(out,11,)”) in new stack
– Executing [s@sub-record-check:1] Set(“SIP/119-00000124”, “REC_POLICY_MODE_SAVE=”) in new stack
– Executing [s@sub-record-check:2] GotoIf(“SIP/119-00000124”, “1?check”) in new stack
– Goto (sub-record-check,s,7)
– Executing [s@sub-record-check:7] Set(“SIP/119-00000124”, “__MON_FMT=wav”) in new stack
– Executing [s@sub-record-check:8] GotoIf(“SIP/119-00000124”, “1?next”) in new stack
– Goto (sub-record-check,s,11)
– Executing [s@sub-record-check:11] ExecIf(“SIP/119-00000124”, “0?Return()”) in new stack
– Executing [s@sub-record-check:12] ExecIf(“SIP/119-00000124”, “0?Set(__REC_POLICY_MODE=)”) in new stack
– Executing [s@sub-record-check:13] GotoIf(“SIP/119-00000124”, “0?out,1”) in new stack
– Executing [s@sub-record-check:14] Set(“SIP/119-00000124”, “__REC_STATUS=INITIALIZED”) in new stack
– Executing [s@sub-record-check:15] Set(“SIP/119-00000124”, “NOW=1434674979”) in new stack
– Executing [s@sub-record-check:16] Set(“SIP/119-00000124”, “__DAY=19”) in new stack
– Executing [s@sub-record-check:17] Set(“SIP/119-00000124”, “__MONTH=06”) in new stack
– Executing [s@sub-record-check:18] Set(“SIP/119-00000124”, “__YEAR=2015”) in new stack
– Executing [s@sub-record-check:19] Set(“SIP/119-00000124”, “__TIMESTR=20150619-104939”) in new stack
– Executing [s@sub-record-check:20] Set(“SIP/119-00000124”, “__FROMEXTEN=119”) in new stack
– Executing [s@sub-record-check:21] Set(“SIP/119-00000124”, “__CALLFILENAME=out-11-119-20150619-104939-1434674979.292”) in new stack
– Executing [s@sub-record-check:22] Goto(“SIP/119-00000124”, “out,1”) in new stack
– Goto (sub-record-check,out,1)
– Executing [out@sub-record-check:1] ExecIf(“SIP/119-00000124”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
– Executing [out@sub-record-check:2] GosubIf(“SIP/119-00000124”, “0?record,1(exten,11,119)”) in new stack
– Executing [out@sub-record-check:3] Return(“SIP/119-00000124”, “”) in new stack
– Executing [11@from-internal:6] Macro(“SIP/119-00000124”, “dialout-trunk,2,11,on”) in new stack
– Executing [s@macro-dialout-trunk:1] Set(“SIP/119-00000124”, “DIAL_TRUNK=2”) in new stack
– Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/119-00000124”, “0?sub-pincheck,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/119-00000124”, “0?disabletrunk,1”) in new stack
– Executing [s@macro-dialout-trunk:4] Set(“SIP/119-00000124”, “DIAL_NUMBER=11”) in new stack
– Executing [s@macro-dialout-trunk:5] Set(“SIP/119-00000124”, “DIAL_TRUNK_OPTIONS=Ttr”) in new stack
– Executing [s@macro-dialout-trunk:6] Set(“SIP/119-00000124”, “OUTBOUND_GROUP=OUT_2”) in new stack
– Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/119-00000124”, “1?nomax”) in new stack
– Goto (macro-dialout-trunk,s,9)
– Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/119-00000124”, “0?skipoutcid”) in new stack
– Executing [s@macro-dialout-trunk:10] Set(“SIP/119-00000124”, “DIAL_TRUNK_OPTIONS=”) in new stack
– Executing [s@macro-dialout-trunk:11] Macro(“SIP/119-00000124”, “outbound-callerid,2”) in new stack
– Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/119-00000124”, “0?Set(CALLERPRES()=)”) in new stack
– Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/119-00000124”, “0?Set(REALCALLERIDNUM=119)”) in new stack
– Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/119-00000124”, “1?normcid”) in new stack
– Goto (macro-outbound-callerid,s,6)
– Executing [s@macro-outbound-callerid:6] Set(“SIP/119-00000124”, “USEROUTCID=”) in new stack
– Executing [s@macro-outbound-callerid:7] Set(“SIP/119-00000124”, “EMERGENCYCID=”) in new stack
– Executing [s@macro-outbound-callerid:8] Set(“SIP/119-00000124”, “TRUNKOUTCID=61390216143”) in new stack
– Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/119-00000124”, “1?trunkcid”) in new stack
– Goto (macro-outbound-callerid,s,14)
– Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/119-00000124”, “1?Set(CALLERID(all)=61390216143)”) in new stack
– Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/119-00000124”, “0?Set(CALLERID(all)=)”) in new stack
– Executing [s@macro-outbound-callerid:16] ExecIf(“SIP/119-00000124”, “1?Set(CALLERID(all)=0352296844)”) in new stack
– Executing [s@macro-outbound-callerid:17] ExecIf(“SIP/119-00000124”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
– Executing [s@macro-outbound-callerid:18] Set(“SIP/119-00000124”, “CDR(outbound_cnum)=0352296844”) in new stack
– Executing [s@macro-outbound-callerid:19] Set(“SIP/119-00000124”, “CDR(outbound_cnam)=”) in new stack
– Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/119-00000124”, “0?sub-flp-2,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:13] Set(“SIP/119-00000124”, “OUTNUM=11”) in new stack
– Executing [s@macro-dialout-trunk:14] Set(“SIP/119-00000124”, “custom=SIP/b61390216143”) in new stack
– Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/119-00000124”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
– Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/119-00000124”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
– Executing [s@macro-dialout-trunk:17] Macro(“SIP/119-00000124”, “dialout-trunk-predial-hook,”) in new stack
– Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/119-00000124”, “”) in new stack
– Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/119-00000124”, “0?bypass,1”) in new stack
– Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/119-00000124”, “1?Set(CONNECTEDLINE(num,i)=11)”) in new stack
– Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/119-00000124”, “1?Set(CONNECTEDLINE(name,i)=CID:0352296844)”) in new stack
– Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/119-00000124”, “0?customtrunk”) in new stack
– Executing [s@macro-dialout-trunk:22] Dial(“SIP/119-00000124”, “SIP/b61390216143/11,300,”) in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Called SIP/b61390216143/11
== Everyone is busy/congested at this time (1:0/0/1)
– Executing [s@macro-dialout-trunk:23] NoOp(“SIP/119-00000124”, "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and

HANGUPCAUSE = 1") in new stack
– Executing [s@macro-dialout-trunk:24] GotoIf(“SIP/119-00000124”, “1?continue,1:s-CHANUNAVAIL,1”) in new stack
– Goto (macro-dialout-trunk,continue,1)
– Executing [continue@macro-dialout-trunk:1] NoOp(“SIP/119-00000124”, "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 1 - failing

through to other trunks") in new stack
– Executing [continue@macro-dialout-trunk:2] Set(“SIP/119-00000124”, “CALLERID(number)=119”) in new stack
– Executing [11@from-internal:7] Macro(“SIP/119-00000124”, “outisbusy,”) in new stack
– Executing [s@macro-outisbusy:1] Progress(“SIP/119-00000124”, “”) in new stack
– Executing [s@macro-outisbusy:2] GotoIf(“SIP/119-00000124”, “0?emergency,1”) in new stack
– Executing [s@macro-outisbusy:3] GotoIf(“SIP/119-00000124”, “0?intracompany,1”) in new stack
– Executing [s@macro-outisbusy:4] Playback(“SIP/119-00000124”, “all-circuits-busy-now&pls-try-call-later, noanswer”) in new stack
– <SIP/119-00000124> Playing ‘all-circuits-busy-now.ulaw’ (language ‘en’)
– <SIP/119-00000124> Playing ‘pls-try-call-later.ulaw’ (language ‘en’)
– Executing [s@macro-outisbusy:5] Congestion(“SIP/119-00000124”, “20”) in new stack
[2015-06-19 10:49:43] WARNING[57386]: channel.c:4753 ast_prod: Prodding channel ‘SIP/119-00000124’ failed
== Spawn extension (macro-outisbusy, s, 5) exited non-zero on ‘SIP/119-00000124’ in macro ‘outisbusy’
== Spawn extension (from-internal, 11, 7) exited non-zero on ‘SIP/119-00000124’
– Executing [h@from-internal:1] Hangup(“SIP/119-00000124”, “”) in new stack
== Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/119-00000124’
AxcessPBXCLI>
AxcessPBX
CLI>

Dial extension and then hit speaker or lift handset (lift handset or speaker button first and get dial tone and see above)

AxcessPBXCLI>
AxcessPBX
CLI>
AxcessPBXCLI>
AxcessPBX
CLI>
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [117@from-internal:1] Set(“SIP/119-00000120”, “__RINGTIMER=15”) in new stack
– Executing [117@from-internal:2] Macro(“SIP/119-00000120”, “exten-vm,117,117,0,0,0”) in new stack
– Executing [s@macro-exten-vm:1] Macro(“SIP/119-00000120”, “user-callerid,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/119-00000120”, “TOUCH_MONITOR=1434674817.288”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/119-00000120”, “AMPUSER=119”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/119-00000120”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/119-00000120”, “1?Set(REALCALLERIDNUM=119)”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/119-00000120”, “AMPUSER=119”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/119-00000120”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/119-00000120”, “AMPUSERCIDNAME=Spare”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/119-00000120”, “0?report”) in new stack
– Executing [s@macro-user-callerid:9] Set(“SIP/119-00000120”, “AMPUSERCID=119”) in new stack
– Executing [s@macro-user-callerid:10] Set(“SIP/119-00000120”, “__DIAL_OPTIONS=Ttr”) in new stack
– Executing [s@macro-user-callerid:11] Set(“SIP/119-00000120”, “CALLERID(all)=“Spare” <119>”) in new stack
– Executing [s@macro-user-callerid:12] GotoIf(“SIP/119-00000120”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:13] ExecIf(“SIP/119-00000120”, “0?Set(GROUP(concurrency_limit)=119)”) in new stack
– Executing [s@macro-user-callerid:14] GosubIf(“SIP/119-00000120”, “7?sub-ccss,s,1(macro-exten-vm,117)”) in new stack
– Executing [s@sub-ccss:1] ExecIf(“SIP/119-00000120”, “0?Return()”) in new stack
– Executing [s@sub-ccss:2] Set(“SIP/119-00000120”, “CCSS_SETUP=TRUE”) in new stack
– Executing [s@sub-ccss:3] GosubIf(“SIP/119-00000120”, "0?monitor_config,1(macro-exten-vm,117):monitor_default,1(macro-exten-

vm,117)") in new stack
– Executing [monitor_default@sub-ccss:1] GotoIf(“SIP/119-00000120”, “1?is_exten”) in new stack
– Goto (sub-ccss,monitor_default,4)
– Executing [monitor_default@sub-ccss:4] Set(“SIP/119-00000120”, “CALLCOMPLETION(cc_monitor_policy)=generic”) in new stack
– Executing [monitor_default@sub-ccss:5] Set(“SIP/119-00000120”, “CALLCOMPLETION(cc_max_monitors)=5”) in new stack
– Executing [monitor_default@sub-ccss:6] Return(“SIP/119-00000120”, “TRUE”) in new stack
– Executing [s@sub-ccss:4] GosubIf(“SIP/119-00000120”, “7?agent_config,1():agent_default,1()”) in new stack
– Executing [agent_config@sub-ccss:1] Set(“SIP/119-00000120”, “CALLCOMPLETION(cc_agent_policy)=generic”) in new stack
– Executing [agent_config@sub-ccss:2] Set(“SIP/119-00000120”, “CALLCOMPLETION(cc_offer_timer)=30”) in new stack
– Executing [agent_config@sub-ccss:3] Set(“SIP/119-00000120”, “CALLCOMPLETION(ccbs_available_timer)=”) in new stack
[2015-06-19 10:46:57] WARNING[57134]: ccss.c:834 ast_set_ccbs_available_timer: 0 is an invalid value for ccbs_available_timer. Retaining

value as 4800
– Executing [agent_config@sub-ccss:4] Set(“SIP/119-00000120”, “CALLCOMPLETION(ccnr_available_timer)=”) in new stack
[2015-06-19 10:46:57] WARNING[57134]: ccss.c:804 ast_set_ccnr_available_timer: 0 is an invalid value for ccnr_available_timer. Retaining

value as 7200
– Executing [agent_config@sub-ccss:5] Set(“SIP/119-00000120”, “CALLCOMPLETION(cc_callback_macro)=ccss-default”) in new stack
– Executing [agent_config@sub-ccss:6] ExecIf(“SIP/119-00000120”, “1?Set(CALLCOMPLETION(cc_recall_timer)=)”) in new stack
[2015-06-19 10:46:57] WARNING[57134]: ccss.c:819 ast_set_cc_recall_timer: 0 is an invalid value for ccnr_available_timer. Retaining value

as 20
– Executing [agent_config@sub-ccss:7] ExecIf(“SIP/119-00000120”, “1?Set(CALLCOMPLETION(cc_max_agents)=)”) in new stack
– Executing [agent_config@sub-ccss:8] ExecIf(“SIP/119-00000120”, "0?Set(CALLCOMPLETION(cc_agent_dialstring)=Local/119_117@from-

ccss-)") in new stack
– Executing [agent_config@sub-ccss:9] Set(“SIP/119-00000120”, “CALLCOMPLETION(cc_callback_macro)=ccss-default”) in new stack
– Executing [agent_config@sub-ccss:10] Return(“SIP/119-00000120”, “”) in new stack
– Executing [s@sub-ccss:5] Set(“SIP/119-00000120”, “DB(AMPUSER/119/ccss/last_number)=117”) in new stack
– Executing [s@sub-ccss:6] Return(“SIP/119-00000120”, “”) in new stack
– Executing [s@macro-user-callerid:15] ExecIf(“SIP/119-00000120”, “0?Set(CHANNEL(language)=)”) in new stack
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/119-00000120”, “0?continue”) in new stack
– Executing [s@macro-user-callerid:17] Set(“SIP/119-00000120”, “__TTL=64”) in new stack
– Executing [s@macro-user-callerid:18] GotoIf(“SIP/119-00000120”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,29)
– Executing [s@macro-user-callerid:29] Set(“SIP/119-00000120”, “CALLERID(number)=119”) in new stack
– Executing [s@macro-user-callerid:30] Set(“SIP/119-00000120”, “CALLERID(name)=Spare”) in new stack
– Executing [s@macro-user-callerid:31] Set(“SIP/119-00000120”, “CDR(cnum)=119”) in new stack
– Executing [s@macro-user-callerid:32] Set(“SIP/119-00000120”, “CDR(cnam)=Spare”) in new stack
– Executing [s@macro-user-callerid:33] Set(“SIP/119-00000120”, “CHANNEL(language)=en”) in new stack
– Executing [s@macro-exten-vm:2] Set(“SIP/119-00000120”, “RingGroupMethod=none”) in new stack
– Executing [s@macro-exten-vm:3] Set(“SIP/119-00000120”, “__EXTTOCALL=117”) in new stack
– Executing [s@macro-exten-vm:4] Set(“SIP/119-00000120”, “__PICKUPMARK=117”) in new stack
– Executing [s@macro-exten-vm:5] Set(“SIP/119-00000120”, “RT=15”) in new stack
– Executing [s@macro-exten-vm:6] ExecIf(“SIP/119-00000120”, “0?Macro(vm,117,DIRECTDIAL,)”) in new stack
– Executing [s@macro-exten-vm:7] ExecIf(“SIP/119-00000120”, “0?MacroExit()”) in new stack
– Executing [s@macro-exten-vm:8] Gosub(“SIP/119-00000120”, “sub-record-check,s,1(exten,117,)”) in new stack
– Executing [s@sub-record-check:1] Set(“SIP/119-00000120”, “REC_POLICY_MODE_SAVE=”) in new stack
– Executing [s@sub-record-check:2] GotoIf(“SIP/119-00000120”, “1?check”) in new stack
– Goto (sub-record-check,s,7)
– Executing [s@sub-record-check:7] Set(“SIP/119-00000120”, “__MON_FMT=wav”) in new stack
– Executing [s@sub-record-check:8] GotoIf(“SIP/119-00000120”, “1?next”) in new stack
– Goto (sub-record-check,s,11)
– Executing [s@sub-record-check:11] ExecIf(“SIP/119-00000120”, “0?Return()”) in new stack
– Executing [s@sub-record-check:12] ExecIf(“SIP/119-00000120”, “0?Set(__REC_POLICY_MODE=)”) in new stack
– Executing [s@sub-record-check:13] GotoIf(“SIP/119-00000120”, “0?exten,1”) in new stack
– Executing [s@sub-record-check:14] Set(“SIP/119-00000120”, “__REC_STATUS=INITIALIZED”) in new stack
– Executing [s@sub-record-check:15] Set(“SIP/119-00000120”, “NOW=1434674817”) in new stack
– Executing [s@sub-record-check:16] Set(“SIP/119-00000120”, “__DAY=19”) in new stack
– Executing [s@sub-record-check:17] Set(“SIP/119-00000120”, “__MONTH=06”) in new stack
– Executing [s@sub-record-check:18] Set(“SIP/119-00000120”, “__YEAR=2015”) in new stack
– Executing [s@sub-record-check:19] Set(“SIP/119-00000120”, “__TIMESTR=20150619-104657”) in new stack
– Executing [s@sub-record-check:20] Set(“SIP/119-00000120”, “__FROMEXTEN=119”) in new stack
– Executing [s@sub-record-check:21] Set(“SIP/119-00000120”, “__CALLFILENAME=exten-117-119-20150619-104657-1434674817.288”) in new

stack
– Executing [s@sub-record-check:22] Goto(“SIP/119-00000120”, “exten,1”) in new stack
– Goto (sub-record-check,exten,1)
– Executing [exten@sub-record-check:1] GotoIf(“SIP/119-00000120”, “0?callee”) in new stack
– Executing [exten@sub-record-check:2] Set(“SIP/119-00000120”, “__REC_POLICY_MODE=dontcare”) in new stack
– Executing [exten@sub-record-check:3] GotoIf(“SIP/119-00000120”, “1?caller”) in new stack
– Goto (sub-record-check,exten,10)
– Executing [exten@sub-record-check:10] Set(“SIP/119-00000120”, “__REC_POLICY_MODE=dontcare”) in new stack
– Executing [exten@sub-record-check:11] GosubIf(“SIP/119-00000120”, “0?record,1(exten,117,119)”) in new stack
– Executing [exten@sub-record-check:12] Return(“SIP/119-00000120”, “”) in new stack
– Executing [s@macro-exten-vm:9] GotoIf(“SIP/119-00000120”, “1?macrodial”) in new stack
– Goto (macro-exten-vm,s,15)
– Executing [s@macro-exten-vm:15] GosubIf(“SIP/119-00000120”, “0?clrheader,1()”) in new stack
– Executing [s@macro-exten-vm:16] Macro(“SIP/119-00000120”, “dial-one,15,Ttr,117”) in new stack
– Executing [s@macro-dial-one:1] Set(“SIP/119-00000120”, “DEXTEN=117”) in new stack
– Executing [s@macro-dial-one:2] Set(“SIP/119-00000120”, “DIALSTATUS_CW=”) in new stack
– Executing [s@macro-dial-one:3] GosubIf(“SIP/119-00000120”, “0?screen,1()”) in new stack
– Executing [s@macro-dial-one:4] GosubIf(“SIP/119-00000120”, “0?cf,1()”) in new stack
– Executing [s@macro-dial-one:5] GotoIf(“SIP/119-00000120”, “1?skip1”) in new stack
– Goto (macro-dial-one,s,8)
– Executing [s@macro-dial-one:8] GotoIf(“SIP/119-00000120”, “0?nodial”) in new stack
– Executing [s@macro-dial-one:9] GotoIf(“SIP/119-00000120”, “0?continue”) in new stack
– Executing [s@macro-dial-one:10] Set(“SIP/119-00000120”, “EXTHASCW=ENABLED”) in new stack
– Executing [s@macro-dial-one:11] GotoIf(“SIP/119-00000120”, “0?next1:cwinusebusy”) in new stack
– Goto (macro-dial-one,s,23)
– Executing [s@macro-dial-one:23] GotoIf(“SIP/119-00000120”, “1?next3:continue”) in new stack
– Goto (macro-dial-one,s,24)
– Executing [s@macro-dial-one:24] ExecIf(“SIP/119-00000120”, “1?Set(DIALSTATUS_CW=BUSY)”) in new stack
– Executing [s@macro-dial-one:25] GotoIf(“SIP/119-00000120”, “0?nodial”) in new stack
– Executing [s@macro-dial-one:26] GosubIf(“SIP/119-00000120”, “1?dstring,1():dlocal,1()”) in new stack
– Executing [dstring@macro-dial-one:1] Set(“SIP/119-00000120”, “DSTRING=”) in new stack
– Executing [dstring@macro-dial-one:2] Set(“SIP/119-00000120”, “DEVICES=117”) in new stack
– Executing [dstring@macro-dial-one:3] ExecIf(“SIP/119-00000120”, “0?Return()”) in new stack
– Executing [dstring@macro-dial-one:4] ExecIf(“SIP/119-00000120”, “0?Set(DEVICES=17)”) in new stack
– Executing [dstring@macro-dial-one:5] Set(“SIP/119-00000120”, “LOOPCNT=1”) in new stack
– Executing [dstring@macro-dial-one:6] Set(“SIP/119-00000120”, “ITER=1”) in new stack
– Executing [dstring@macro-dial-one:7] Set(“SIP/119-00000120”, “THISDIAL=SIP/117”) in new stack
– Executing [dstring@macro-dial-one:8] GosubIf(“SIP/119-00000120”, “1?zap2dahdi,1()”) in new stack
– Executing [zap2dahdi@macro-dial-one:1] ExecIf(“SIP/119-00000120”, “0?Return()”) in new stack
– Executing [zap2dahdi@macro-dial-one:2] Set(“SIP/119-00000120”, “NEWDIAL=”) in new stack
– Executing [zap2dahdi@macro-dial-one:3] Set(“SIP/119-00000120”, “LOOPCNT2=1”) in new stack
– Executing [zap2dahdi@macro-dial-one:4] Set(“SIP/119-00000120”, “ITER2=1”) in new stack
– Executing [zap2dahdi@macro-dial-one:5] Set(“SIP/119-00000120”, “THISPART2=SIP/117”) in new stack
– Executing [zap2dahdi@macro-dial-one:6] ExecIf(“SIP/119-00000120”, “0?Set(THISPART2=DAHDI/117)”) in new stack
– Executing [zap2dahdi@macro-dial-one:7] Set(“SIP/119-00000120”, “NEWDIAL=SIP/117&”) in new stack
– Executing [zap2dahdi@macro-dial-one:8] Set(“SIP/119-00000120”, “ITER2=2”) in new stack
– Executing [zap2dahdi@macro-dial-one:9] GotoIf(“SIP/119-00000120”, “0?begin2”) in new stack
– Executing [zap2dahdi@macro-dial-one:10] Set(“SIP/119-00000120”, “THISDIAL=SIP/117”) in new stack
– Executing [zap2dahdi@macro-dial-one:11] Return(“SIP/119-00000120”, “”) in new stack
– Executing [dstring@macro-dial-one:9] Set(“SIP/119-00000120”, “DSTRING=SIP/117&”) in new stack
– Executing [dstring@macro-dial-one:10] Set(“SIP/119-00000120”, “ITER=2”) in new stack
– Executing [dstring@macro-dial-one:11] GotoIf(“SIP/119-00000120”, “0?begin”) in new stack
– Executing [dstring@macro-dial-one:12] Set(“SIP/119-00000120”, “DSTRING=SIP/117”) in new stack
– Executing [dstring@macro-dial-one:13] Return(“SIP/119-00000120”, “”) in new stack
– Executing [s@macro-dial-one:27] GotoIf(“SIP/119-00000120”, “0?nodial”) in new stack
– Executing [s@macro-dial-one:28] GotoIf(“SIP/119-00000120”, “0?skiptrace”) in new stack
– Executing [s@macro-dial-one:29] GosubIf(“SIP/119-00000120”, “1?ctset,1():ctclear,1()”) in new stack
– Executing [ctset@macro-dial-one:1] Set(“SIP/119-00000120”, “DB(CALLTRACE/117)=119”) in new stack
– Executing [ctset@macro-dial-one:2] Return(“SIP/119-00000120”, “”) in new stack
– Executing [s@macro-dial-one:30] Set(“SIP/119-00000120”, “D_OPTIONS=Ttr”) in new stack
– Executing [s@macro-dial-one:31] ExecIf(“SIP/119-00000120”, “0?SIPAddHeader(Alert-Info: )”) in new stack
– Executing [s@macro-dial-one:32] ExecIf(“SIP/119-00000120”, “0?SIPAddHeader()”) in new stack
– Executing [s@macro-dial-one:33] ExecIf(“SIP/119-00000120”, “0?Set(CHANNEL(musicclass)=)”) in new stack
– Executing [s@macro-dial-one:34] GosubIf(“SIP/119-00000120”, “0?qwait,1()”) in new stack
– Executing [s@macro-dial-one:35] Set(“SIP/119-00000120”, “__CWIGNORE=”) in new stack
– Executing [s@macro-dial-one:36] Set(“SIP/119-00000120”, “__KEEPCID=TRUE”) in new stack
– Executing [s@macro-dial-one:37] GotoIf(“SIP/119-00000120”, “0?usegoto,1”) in new stack
– Executing [s@macro-dial-one:38] GotoIf(“SIP/119-00000120”, “0?godial”) in new stack
– Executing [s@macro-dial-one:39] Set(“SIP/119-00000120”, “CONNECTEDLINE(name,i)=Spare Desk”) in new stack
– Executing [s@macro-dial-one:40] Set(“SIP/119-00000120”, “CONNECTEDLINE(num)=117”) in new stack
– Executing [s@macro-dial-one:41] Set(“SIP/119-00000120”, “D_OPTIONS=TtrI”) in new stack
– Executing [s@macro-dial-one:42] Dial(“SIP/119-00000120”, “SIP/117,15,TtrI”) in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Called SIP/117
– Connected line update to SIP/119-00000120 prevented.
– SIP/117-00000121 is ringing
== Spawn extension (macro-dial-one, s, 42) exited non-zero on ‘SIP/119-00000120’ in macro ‘dial-one’
== Spawn extension (macro-exten-vm, s, 16) exited non-zero on ‘SIP/119-00000120’ in macro ‘exten-vm’
== Spawn extension (from-internal, 117, 2) exited non-zero on ‘SIP/119-00000120’
– Executing [h@from-internal:1] Hangup(“SIP/119-00000120”, “”) in new stack
== Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/119-00000120’
AxcessPBXCLI>
AxcessPBX
CLI>

(end CLI, regular call will be posted in a reply message)

Osyrys

Dialing a normal number

AxcessPBXCLI>
AxcessPBX
CLI>
AxcessPBXCLI>
AxcessPBX
CLI>
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [0731676665@from-internal:1] Macro(“SIP/119-00000122”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/119-00000122”, “TOUCH_MONITOR=1434674856.290”) in new stack
– Executing [s@macro-user-callerid:2] Set(“SIP/119-00000122”, “AMPUSER=119”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“SIP/119-00000122”, “0?report”) in new stack
– Executing [s@macro-user-callerid:4] ExecIf(“SIP/119-00000122”, “1?Set(REALCALLERIDNUM=119)”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/119-00000122”, “AMPUSER=119”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/119-00000122”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/119-00000122”, “AMPUSERCIDNAME=Spare”) in new stack
– Executing [s@macro-user-callerid:8] GotoIf(“SIP/119-00000122”, “0?report”) in new stack
– Executing [s@macro-user-callerid:9] Set(“SIP/119-00000122”, “AMPUSERCID=119”) in new stack
– Executing [s@macro-user-callerid:10] Set(“SIP/119-00000122”, “__DIAL_OPTIONS=Ttr”) in new stack
– Executing [s@macro-user-callerid:11] Set(“SIP/119-00000122”, “CALLERID(all)=“Spare” <119>”) in new stack
– Executing [s@macro-user-callerid:12] GotoIf(“SIP/119-00000122”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:13] ExecIf(“SIP/119-00000122”, “1?Set(GROUP(concurrency_limit)=119)”) in new stack
– Executing [s@macro-user-callerid:14] GosubIf(“SIP/119-00000122”, “7?sub-ccss,s,1(from-internal,0731676665)”) in new stack
– Executing [s@sub-ccss:1] ExecIf(“SIP/119-00000122”, “0?Return()”) in new stack
– Executing [s@sub-ccss:2] Set(“SIP/119-00000122”, “CCSS_SETUP=TRUE”) in new stack
– Executing [s@sub-ccss:3] GosubIf(“SIP/119-00000122”, "0?monitor_config,1(from-internal,0731676665):monitor_default,1(from-

internal,0731676665)") in new stack
– Executing [monitor_default@sub-ccss:1] GotoIf(“SIP/119-00000122”, “0?is_exten”) in new stack
– Executing [monitor_default@sub-ccss:2] StackPop(“SIP/119-00000122”, “”) in new stack
– Executing [monitor_default@sub-ccss:3] Return(“SIP/119-00000122”, “FALSE”) in new stack
– Executing [s@macro-user-callerid:15] ExecIf(“SIP/119-00000122”, “0?Set(CHANNEL(language)=)”) in new stack
– Executing [s@macro-user-callerid:16] GotoIf(“SIP/119-00000122”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,29)
– Executing [s@macro-user-callerid:29] Set(“SIP/119-00000122”, “CALLERID(number)=119”) in new stack
– Executing [s@macro-user-callerid:30] Set(“SIP/119-00000122”, “CALLERID(name)=Spare”) in new stack
– Executing [s@macro-user-callerid:31] Set(“SIP/119-00000122”, “CDR(cnum)=119”) in new stack
– Executing [s@macro-user-callerid:32] Set(“SIP/119-00000122”, “CDR(cnam)=Spare”) in new stack
– Executing [s@macro-user-callerid:33] Set(“SIP/119-00000122”, “CHANNEL(language)=en”) in new stack
– Executing [0731676665@from-internal:2] Set(“SIP/119-00000122”, “MOHCLASS=default”) in new stack
– Executing [0731676665@from-internal:3] ExecIf(“SIP/119-00000122”, “1?Set(TRUNKCIDOVERRIDE=0352296844)”) in new stack
– Executing [0731676665@from-internal:4] Set(“SIP/119-00000122”, “_NODEST=”) in new stack
– Executing [0731676665@from-internal:5] Gosub(“SIP/119-00000122”, “sub-record-check,s,1(out,0731676665,)”) in new stack
– Executing [s@sub-record-check:1] Set(“SIP/119-00000122”, “REC_POLICY_MODE_SAVE=”) in new stack
– Executing [s@sub-record-check:2] GotoIf(“SIP/119-00000122”, “1?check”) in new stack
– Goto (sub-record-check,s,7)
– Executing [s@sub-record-check:7] Set(“SIP/119-00000122”, “__MON_FMT=wav”) in new stack
– Executing [s@sub-record-check:8] GotoIf(“SIP/119-00000122”, “1?next”) in new stack
– Goto (sub-record-check,s,11)
– Executing [s@sub-record-check:11] ExecIf(“SIP/119-00000122”, “0?Return()”) in new stack
– Executing [s@sub-record-check:12] ExecIf(“SIP/119-00000122”, “0?Set(__REC_POLICY_MODE=)”) in new stack
– Executing [s@sub-record-check:13] GotoIf(“SIP/119-00000122”, “0?out,1”) in new stack
– Executing [s@sub-record-check:14] Set(“SIP/119-00000122”, “__REC_STATUS=INITIALIZED”) in new stack
– Executing [s@sub-record-check:15] Set(“SIP/119-00000122”, “NOW=1434674856”) in new stack
– Executing [s@sub-record-check:16] Set(“SIP/119-00000122”, “__DAY=19”) in new stack
– Executing [s@sub-record-check:17] Set(“SIP/119-00000122”, “__MONTH=06”) in new stack
– Executing [s@sub-record-check:18] Set(“SIP/119-00000122”, “__YEAR=2015”) in new stack
– Executing [s@sub-record-check:19] Set(“SIP/119-00000122”, “__TIMESTR=20150619-104736”) in new stack
– Executing [s@sub-record-check:20] Set(“SIP/119-00000122”, “__FROMEXTEN=119”) in new stack
– Executing [s@sub-record-check:21] Set(“SIP/119-00000122”, “__CALLFILENAME=out-0731676665-119-20150619-104736-1434674856.290”) in

new stack
– Executing [s@sub-record-check:22] Goto(“SIP/119-00000122”, “out,1”) in new stack
– Goto (sub-record-check,out,1)
– Executing [out@sub-record-check:1] ExecIf(“SIP/119-00000122”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
– Executing [out@sub-record-check:2] GosubIf(“SIP/119-00000122”, “0?record,1(exten,0731676665,119)”) in new stack
– Executing [out@sub-record-check:3] Return(“SIP/119-00000122”, “”) in new stack
– Executing [0731676665@from-internal:6] Macro(“SIP/119-00000122”, “dialout-trunk,2,0731676665,on”) in new stack
– Executing [s@macro-dialout-trunk:1] Set(“SIP/119-00000122”, “DIAL_TRUNK=2”) in new stack
– Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/119-00000122”, “0?sub-pincheck,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/119-00000122”, “0?disabletrunk,1”) in new stack
– Executing [s@macro-dialout-trunk:4] Set(“SIP/119-00000122”, “DIAL_NUMBER=0731676665”) in new stack
– Executing [s@macro-dialout-trunk:5] Set(“SIP/119-00000122”, “DIAL_TRUNK_OPTIONS=Ttr”) in new stack
– Executing [s@macro-dialout-trunk:6] Set(“SIP/119-00000122”, “OUTBOUND_GROUP=OUT_2”) in new stack
– Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/119-00000122”, “1?nomax”) in new stack
– Goto (macro-dialout-trunk,s,9)
– Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/119-00000122”, “0?skipoutcid”) in new stack
– Executing [s@macro-dialout-trunk:10] Set(“SIP/119-00000122”, “DIAL_TRUNK_OPTIONS=”) in new stack
– Executing [s@macro-dialout-trunk:11] Macro(“SIP/119-00000122”, “outbound-callerid,2”) in new stack
– Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/119-00000122”, “0?Set(CALLERPRES()=)”) in new stack
– Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/119-00000122”, “0?Set(REALCALLERIDNUM=119)”) in new stack
– Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/119-00000122”, “1?normcid”) in new stack
– Goto (macro-outbound-callerid,s,6)
– Executing [s@macro-outbound-callerid:6] Set(“SIP/119-00000122”, “USEROUTCID=”) in new stack
– Executing [s@macro-outbound-callerid:7] Set(“SIP/119-00000122”, “EMERGENCYCID=”) in new stack
– Executing [s@macro-outbound-callerid:8] Set(“SIP/119-00000122”, “TRUNKOUTCID=61390216143”) in new stack
– Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/119-00000122”, “1?trunkcid”) in new stack
– Goto (macro-outbound-callerid,s,14)
– Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/119-00000122”, “1?Set(CALLERID(all)=61390216143)”) in new stack
– Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/119-00000122”, “0?Set(CALLERID(all)=)”) in new stack
– Executing [s@macro-outbound-callerid:16] ExecIf(“SIP/119-00000122”, “1?Set(CALLERID(all)=0352296844)”) in new stack
– Executing [s@macro-outbound-callerid:17] ExecIf(“SIP/119-00000122”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
– Executing [s@macro-outbound-callerid:18] Set(“SIP/119-00000122”, “CDR(outbound_cnum)=0352296844”) in new stack
– Executing [s@macro-outbound-callerid:19] Set(“SIP/119-00000122”, “CDR(outbound_cnam)=”) in new stack
– Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/119-00000122”, “0?sub-flp-2,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:13] Set(“SIP/119-00000122”, “OUTNUM=0731676665”) in new stack
– Executing [s@macro-dialout-trunk:14] Set(“SIP/119-00000122”, “custom=SIP/b61390216143”) in new stack
– Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/119-00000122”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
– Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/119-00000122”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
– Executing [s@macro-dialout-trunk:17] Macro(“SIP/119-00000122”, “dialout-trunk-predial-hook,”) in new stack
– Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/119-00000122”, “”) in new stack
– Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/119-00000122”, “0?bypass,1”) in new stack
– Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/119-00000122”, “1?Set(CONNECTEDLINE(num,i)=0731676665)”) in new stack
– Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/119-00000122”, “1?Set(CONNECTEDLINE(name,i)=CID:0352296844)”) in new stack
– Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/119-00000122”, “0?customtrunk”) in new stack
– Executing [s@macro-dialout-trunk:22] Dial(“SIP/119-00000122”, “SIP/b61390216143/0731676665,300,”) in new stack
== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Called SIP/b61390216143/0731676665
– SIP/b61390216143-00000123 is ringing
== Spawn extension (macro-dialout-trunk, s, 22) exited non-zero on ‘SIP/119-00000122’ in macro ‘dialout-trunk’
== Spawn extension (from-internal, 0731676665, 6) exited non-zero on ‘SIP/119-00000122’
– Executing [h@from-internal:1] Hangup(“SIP/119-00000122”, “”) in new stack
== Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/119-00000122’
AxcessPBXCLI>
AxcessPBX
CLI>
AxcessPBXCLI>
AxcessPBX
CLI>

The log lines are telling us that the working call is sending digits 117 but the non-working call is only sending 11. Since 11 doesn’t map to an inside extension it goes out a trunk and fails. Can’t say why, but it must be a polycom problem, either config issue or perhaps firmware problem.

Polycom Dialplan problem - as a general rule, don’t use extensions beginning with a 1 and the default dialplan works fine.

If you are using Endpoint manager, insert the following into the allowed dial strings:

xxxx|*xxxx|

So that the extensions are an allowed destination - you can confirm this by dialing with the handset in the cradle and putting in your extensions you are having trouble with and then hitting send and they will work - but if you pick up the handset and then dial, you get chopped because of the local parsing of the number - it thinks you are dialing a long-distance call.

If you are not using Endpoint Manager, find the dialplan line in /tftpboot/sip.cfg and insert the above with an additional |3|3 in the timeouts portion - look at the line and it will make sense.