Internal calls fail

General Help
1

Hello guys i had made a post earlier on the Asterisk forums and they directed me over here. My issue is ever since i upgraded from FreePBX version 2.9 to verson 2.11 all internal calls fail. I can make external calls but not internal even when users call into the system and hit our IVR with Direct Dial enabled extensions don’t work and result in the busy signal or if dialed from the IVR result in the IVR repeating. This is my log of an internal call being made:

[2013-05-17 02:50:39] VERBOSE[17940] netsock2.c: == Using SIP VIDEO TOS bits 136 [2013-05-17 02:50:39] VERBOSE[17940] netsock2.c: == Using SIP VIDEO CoS mark 6 [2013-05-17 02:50:39] VERBOSE[17940] netsock2.c: == Using SIP RTP TOS bits 184 [2013-05-17 02:50:39] VERBOSE[17940] netsock2.c: == Using SIP RTP CoS mark 5 [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Set("SIP/1701-00000000", "__RINGTIMER=15") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Macro("SIP/1701-00000000", "exten-vm,novm,1700,0,0,0") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Macro("SIP/1701-00000000", "user-callerid,") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Set("SIP/1701-00000000", "TOUCH_MONITOR=1368773439.0") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "AMPUSER=1701") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] GotoIf("SIP/1701-00000000", "0?report") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] ExecIf("SIP/1701-00000000", "1?Set(REALCALLERIDNUM=1701)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] Set("SIP/1701-00000000", "AMPUSER=1701") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:6] Set("SIP/1701-00000000", "AMPUSERCIDNAME=LeonFox") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:7] GotoIf("SIP/1701-00000000", "0?report") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:8] Set("SIP/1701-00000000", "AMPUSERCID=1701") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:9] Set("SIP/1701-00000000", "__DIAL_OPTIONS=tr") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:10] Set("SIP/1701-00000000", "CALLERID(all)="LeonFox" <1701>") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:11] GotoIf("SIP/1701-00000000", "0?limit") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:12] ExecIf("SIP/1701-00000000", "0?Set(GROUP(concurrency_limit)=1701)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:13] GosubIf("SIP/1701-00000000", "7?sub-ccss,s,1(macro-exten-vm,1700)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] ExecIf("SIP/1701-00000000", "0?Return()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "CCSS_SETUP=TRUE") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] GosubIf("SIP/1701-00000000", "0?monitor_config,1(macro-exten-vm,1700):monitor_default,1(macro-exten-vm,1700)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/1701-00000000", "1?is_exten") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (sub-ccss,monitor_default,4) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] Set("SIP/1701-00000000", "CALLCOMPLETION(cc_monitor_policy)=generic") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] Set("SIP/1701-00000000", "CALLCOMPLETION(cc_max_monitors)=5") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:6] Return("SIP/1701-00000000", "TRUE") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] GosubIf("SIP/1701-00000000", "7?agent_config,1():agent_default,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Set("SIP/1701-00000000", "CALLCOMPLETION(cc_agent_policy)=generic") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "CALLCOMPLETION(cc_offer_timer)=30") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] Set("SIP/1701-00000000", "CALLCOMPLETION(ccbs_available_timer)=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] Set("SIP/1701-00000000", "CALLCOMPLETION(ccnr_available_timer)=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] Set("SIP/1701-00000000", "CALLCOMPLETION(cc_callback_macro)=ccss-default") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:6] ExecIf("SIP/1701-00000000", "1?Set(CALLCOMPLETION(cc_recall_timer)=)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:7] ExecIf("SIP/1701-00000000", "1?Set(CALLCOMPLETION(cc_max_agents)=)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:8] ExecIf("SIP/1701-00000000", "0?Set(CALLCOMPLETION(cc_agent_dialstring)=Local/[email protected])") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:9] Set("SIP/1701-00000000", "CALLCOMPLETION(cc_callback_macro)=ccss-default") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:10] Return("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] Set("SIP/1701-00000000", "DB(AMPUSER/1701/ccss/last_number)=1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:6] Return("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:14] GotoIf("SIP/1701-00000000", "0?continue") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:15] Set("SIP/1701-00000000", "__TTL=64") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:16] GotoIf("SIP/1701-00000000", "1?continue") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (macro-user-callerid,s,27) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:27] Set("SIP/1701-00000000", "CALLERID(number)=1701") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:28] Set("SIP/1701-00000000", "CALLERID(name)=LeonFox") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:29] Set("SIP/1701-00000000", "CDR(cnum)=1701") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:30] Set("SIP/1701-00000000", "CDR(cnam)=LeonFox") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:31] Set("SIP/1701-00000000", "CHANNEL(language)=en") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "RingGroupMethod=none") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] Set("SIP/1701-00000000", "__EXTTOCALL=1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] Set("SIP/1701-00000000", "__PICKUPMARK=1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] Set("SIP/1701-00000000", "RT=15") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:6] Gosub("SIP/1701-00000000", "sub-record-check,s,1(exten,1700,)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Set("SIP/1701-00000000", "REC_POLICY_MODE_SAVE=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] GotoIf("SIP/1701-00000000", "1?check") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (sub-record-check,s,7) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:7] Set("SIP/1701-00000000", "__MON_FMT=wav") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:8] GotoIf("SIP/1701-00000000", "1?next") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (sub-record-check,s,11) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:11] ExecIf("SIP/1701-00000000", "0?Return()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:12] ExecIf("SIP/1701-00000000", "0?Set(__REC_POLICY_MODE=)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:13] GotoIf("SIP/1701-00000000", "0?exten,1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:14] Set("SIP/1701-00000000", "__REC_STATUS=INITIALIZED") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:15] Set("SIP/1701-00000000", "NOW=1368773439") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:16] Set("SIP/1701-00000000", "__DAY=17") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:17] Set("SIP/1701-00000000", "__MONTH=05") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:18] Set("SIP/1701-00000000", "__YEAR=2013") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:19] Set("SIP/1701-00000000", "__TIMESTR=20130517-025039") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:20] Set("SIP/1701-00000000", "__FROMEXTEN=1701") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:21] Set("SIP/1701-00000000", "__CALLFILENAME=exten-1700-1701-20130517-025039-1368773439.0") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:22] Goto("SIP/1701-00000000", "exten,1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (sub-record-check,exten,1) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/1701-00000000", "0?callee") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "__REC_POLICY_MODE=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] GotoIf("SIP/1701-00000000", "0?caller") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] GotoIf("SIP/1701-00000000", "1?callee") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (sub-record-check,exten,8) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:8] GosubIf("SIP/1701-00000000", "0?record,1(exten,1700,1701)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:9] Return("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:7] GotoIf("SIP/1701-00000000", "1?macrodial") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (macro-exten-vm,s,13) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:13] GosubIf("SIP/1701-00000000", "0?clrheader,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:14] Macro("SIP/1701-00000000", "dial-one,15,tr,1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Set("SIP/1701-00000000", "DEXTEN=1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "DIALSTATUS_CW=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] GosubIf("SIP/1701-00000000", "0?screen,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] GosubIf("SIP/1701-00000000", "0?cf,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] GotoIf("SIP/1701-00000000", "1?skip1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (macro-dial-one,s,8) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:8] GotoIf("SIP/1701-00000000", "0?nodial") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:9] GotoIf("SIP/1701-00000000", "0?continue") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:10] Set("SIP/1701-00000000", "EXTHASCW=ENABLED") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:11] GotoIf("SIP/1701-00000000", "0?next1:cwinusebusy") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (macro-dial-one,s,23) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:23] GotoIf("SIP/1701-00000000", "1?next3:continue") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (macro-dial-one,s,24) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:24] ExecIf("SIP/1701-00000000", "0?Set(DIALSTATUS_CW=BUSY)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:25] GotoIf("SIP/1701-00000000", "0?nodial") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:26] GosubIf("SIP/1701-00000000", "1?dstring,1():dlocal,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Set("SIP/1701-00000000", "DSTRING=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "DEVICES=1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] ExecIf("SIP/1701-00000000", "0?Return()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] ExecIf("SIP/1701-00000000", "0?Set(DEVICES=700)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] Set("SIP/1701-00000000", "LOOPCNT=1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:6] Set("SIP/1701-00000000", "ITER=1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:7] Set("SIP/1701-00000000", "THISDIAL=SIP/1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:8] GosubIf("SIP/1701-00000000", "1?zap2dahdi,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] ExecIf("SIP/1701-00000000", "0?Return()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Set("SIP/1701-00000000", "NEWDIAL=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] Set("SIP/1701-00000000", "LOOPCNT2=1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] Set("SIP/1701-00000000", "ITER2=1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:5] Set("SIP/1701-00000000", "THISPART2=SIP/1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:6] ExecIf("SIP/1701-00000000", "0?Set(THISPART2=DAHDI/1700)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:7] Set("SIP/1701-00000000", "NEWDIAL=SIP/1700&") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:8] Set("SIP/1701-00000000", "ITER2=2") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:9] GotoIf("SIP/1701-00000000", "0?begin2") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:10] Set("SIP/1701-00000000", "THISDIAL=SIP/1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:11] Return("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:9] Set("SIP/1701-00000000", "DSTRING=SIP/1700&") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:10] Set("SIP/1701-00000000", "ITER=2") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:11] GotoIf("SIP/1701-00000000", "0?begin") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:12] Set("SIP/1701-00000000", "DSTRING=SIP/1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:13] Return("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:27] GotoIf("SIP/1701-00000000", "0?nodial") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:28] GotoIf("SIP/1701-00000000", "0?skiptrace") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:29] GosubIf("SIP/1701-00000000", "1?ctset,1():ctclear,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Set("SIP/1701-00000000", "DB(CALLTRACE/1700)=1701") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:2] Return("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:30] Set("SIP/1701-00000000", "D_OPTIONS=tr") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:31] ExecIf("SIP/1701-00000000", "0?SIPAddHeader(Alert-Info: )") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:32] ExecIf("SIP/1701-00000000", "0?SIPAddHeader()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:33] ExecIf("SIP/1701-00000000", "0?Set(CHANNEL(musicclass)=)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:34] GosubIf("SIP/1701-00000000", "0?qwait,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:35] Set("SIP/1701-00000000", "__CWIGNORE=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:36] Set("SIP/1701-00000000", "__KEEPCID=TRUE") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:37] GotoIf("SIP/1701-00000000", "0?usegoto,1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:38] GotoIf("SIP/1701-00000000", "0?godial") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:39] Set("SIP/1701-00000000", "CONNECTEDLINE(name,i)=LeonFox") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:40] Set("SIP/1701-00000000", "CONNECTEDLINE(num)=1700") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:41] Set("SIP/1701-00000000", "D_OPTIONS=trI") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:42] Dial("SIP/1701-00000000", "SIP/1700,15,trI") in new stack [2013-05-17 02:50:39] WARNING[18034] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Subscriber absent) [2013-05-17 02:50:39] VERBOSE[18034] app_dial.c: == Everyone is busy/congested at this time (1:0/0/1) [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:43] ExecIf("SIP/1701-00000000", "0?MacroExit()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:44] ExecIf("SIP/1701-00000000", "0?Set(DIALSTATUS=)") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:45] GosubIf("SIP/1701-00000000", "0?s-CHANUNAVAIL,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:46] MacroExit("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:15] Set("SIP/1701-00000000", "SV_DIALSTATUS=CHANUNAVAIL") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:16] GosubIf("SIP/1701-00000000", "0?docfu,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:17] GosubIf("SIP/1701-00000000", "0?docfb,1()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:18] Set("SIP/1701-00000000", "DIALSTATUS=CHANUNAVAIL") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:19] ExecIf("SIP/1701-00000000", "1?MacroExit()") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:3] Set("SIP/1701-00000000", "__PICKUPMARK=") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:4] Goto("SIP/1701-00000000", ",return,1") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Goto (from-internal,return,1) [2013-05-17 02:50:39] WARNING[18034] pbx.c: Channel 'SIP/1701-00000000' sent into invalid extension 'return' in context 'from-internal', but no invalid handler [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:1] Hangup("SIP/1701-00000000", "") in new stack [2013-05-17 02:50:39] VERBOSE[18034] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/1701-00000000'
2 
[2013-05-17 02:50:39] VERBOSE[18034] pbx.c: -- Executing [[email protected]:42] Dial("SIP/1701-00000000", "SIP/1700,15,trI") in new stack
[2013-05-17 02:50:39] WARNING[18034] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Subscriber absent)
[2013-05-17 02:50:39] VERBOSE[18034] app_dial.c: == Everyone is busy/congested at this time (1:0/0/1)

“Subscriber absent” indicates a qualify failure. If you do “sip show peers” do you see extension 1700 showing OK or UNREACHABLE?

3

this is what it outputs, i had to censor some information though:

14xxxx 67.205.xxx.xxx 5060 OK (51 ms)
14xxxx 67.205.xxx.xxx 5060 OK (19 ms)
1700/s (Unspecified) D N A 0 UNKNOWN
1701/1701 68.13.xxx.xxx D N A 5060 OK (81 ms)
1702/1702 72.38.xxx.xxx D N A 14815 OK (21 ms)
1703 (Unspecified) D N A 0 UNKNOWN
1704 (Unspecified) D N A 0 UNKNOWN
1705/s 71.193.xxx.xxx D N A 52640 OK (115 ms)
1709 (Unspecified) D N A 0 UNKNOWN
1710 (Unspecified) D N A 0 UNKNOWN
420 (Unspecified) D N A 0 UNKNOWN
804 (Unspecified) D N A 0 UNKNOWN
TollFreeVMS/14xxxxxx 67.205.xxx.xxx 5060 OK (19 ms)
VM-IN/11929xxxx 204.155.xxx.xxx N 5060 Unmonitored
VoipMS/14xxxx 67.205.xxx.xxx 5060 OK (51 ms)
sipgate2/11xxxxxxx 204.155.xxx.xxx N 5060 Unmonitored
16 sip peers [Monitored: 7 online, 7 offline Unmonitored: 2 online, 0 offline]

4

Ok update on whats happening SOME internal extensions DO work while others do not. DO note that the non-working extensions CAN be registered to and CAN dial out and dial the working extensions they just cannot be called…

5