Zoiper call issues

Hello,

I’ve just installed the latest stable FreePBX Distro, configured Asterisk SIP Settings (my local network is under NAT) and created 2 SIP extensions (100 and 101).

When these extensions are setup in Zoiper (free version), they both register but give 503 Service Unavailable error when trying to call each other.
With XLite (again free version) everything works great.

Nothing else is changed in FreePBX and softphones. I get following logs when trying to call from Zoiper:

[2014-03-18 16:22:02] VERBOSE[1809][C-0000001c] netsock2.c: == Using SIP RTP CoS mark 5 [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "__RINGTIMER=15") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Macro("SIP/100-0000001f", "exten-vm,novm,101,0,0,0") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]o-exten-vm:1] Macro("SIP/100-0000001f", "user-callerid,") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "TOUCH_MONITOR=1395145322.31") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "AMPUSER=100") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] GotoIf("SIP/100-0000001f", "0?report") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] ExecIf("SIP/100-0000001f", "1?Set(REALCALLERIDNUM=100)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] Set("SIP/100-0000001f", "AMPUSER=100") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:6] GotoIf("SIP/100-0000001f", "0?limit") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:7] Set("SIP/100-0000001f", "AMPUSERCIDNAME=Arman Poghosyan") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:8] GotoIf("SIP/100-0000001f", "0?report") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:9] Set("SIP/100-0000001f", "AMPUSERCID=100") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:10] Set("SIP/100-0000001f", "__DIAL_OPTIONS=Ttr") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:11] Set("SIP/100-0000001f", "CALLERID(all)="Arman Poghosyan" <100>") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:12] GotoIf("SIP/100-0000001f", "0?limit") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:13] ExecIf("SIP/100-0000001f", "0?Set(GROUP(concurrency_limit)=100)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:14] GosubIf("SIP/100-0000001f", "7?sub-ccss,s,1(macro-exten-vm,101)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] ExecIf("SIP/100-0000001f", "0?Return()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "CCSS_SETUP=TRUE") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] GosubIf("SIP/100-0000001f", "0?monitor_config,1(macro-exten-vm,101):monitor_default,1(macro-exten-vm,101)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/100-0000001f", "1?is_exten") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (sub-ccss,monitor_default,4) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] Set("SIP/100-0000001f", "CALLCOMPLETION(cc_monitor_policy)=generic") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] Set("SIP/100-0000001f", "CALLCOMPLETION(cc_max_monitors)=5") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:6] Return("SIP/100-0000001f", "TRUE") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] GosubIf("SIP/100-0000001f", "7?agent_config,1():agent_default,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "CALLCOMPLETION(cc_agent_policy)=generic") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "CALLCOMPLETION(cc_offer_timer)=30") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] Set("SIP/100-0000001f", "CALLCOMPLETION(ccbs_available_timer)=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] Set("SIP/100-0000001f", "CALLCOMPLETION(ccnr_available_timer)=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] Set("SIP/100-0000001f", "CALLCOMPLETION(cc_callback_macro)=ccss-default") in new stack [2014-03-18 16:22:02] WARNING[4254][C-0000001c] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead. [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:6] ExecIf("SIP/100-0000001f", "1?Set(CALLCOMPLETION(cc_recall_timer)=)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:7] ExecIf("SIP/100-0000001f", "1?Set(CALLCOMPLETION(cc_max_agents)=)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:8] ExecIf("SIP/100-0000001f", "0?Set(CALLCOMPLETION(cc_agent_dialstring)=Local/[email protected])") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:9] Set("SIP/100-0000001f", "CALLCOMPLETION(cc_callback_macro)=ccss-default") in new stack [2014-03-18 16:22:02] WARNING[4254][C-0000001c] ccss.c: Usage of cc_callback_macro is deprecated. Please use cc_callback_sub instead. [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:10] Return("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] Set("SIP/100-0000001f", "DB(AMPUSER/100/ccss/last_number)=101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:6] Return("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:15] ExecIf("SIP/100-0000001f", "0?Set(CHANNEL(language)=)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:16] GotoIf("SIP/100-0000001f", "0?continue") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:17] Set("SIP/100-0000001f", "__TTL=64") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:18] GotoIf("SIP/100-0000001f", "1?continue") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (macro-user-callerid,s,29) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:29] Set("SIP/100-0000001f", "CALLERID(number)=100") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:30] Set("SIP/100-0000001f", "CALLERID(name)=Arman Poghosyan") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:31] Set("SIP/100-0000001f", "CDR(cnum)=100") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:32] Set("SIP/100-0000001f", "CDR(cnam)=Arman Poghosyan") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:33] Set("SIP/100-0000001f", "CHANNEL(language)=en") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "RingGroupMethod=none") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] Set("SIP/100-0000001f", "__EXTTOCALL=101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] Set("SIP/100-0000001f", "__PICKUPMARK=101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] Set("SIP/100-0000001f", "RT=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:6] ExecIf("SIP/100-0000001f", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:7] ExecIf("SIP/100-0000001f", "0?MacroExit()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:8] Gosub("SIP/100-0000001f", "sub-record-check,s,1(exten,101,)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "REC_POLICY_MODE_SAVE=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] GotoIf("SIP/100-0000001f", "1?check") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (sub-record-check,s,7) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:7] Set("SIP/100-0000001f", "__MON_FMT=wav") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:8] GotoIf("SIP/100-0000001f", "1?next") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (sub-record-check,s,11) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:11] ExecIf("SIP/100-0000001f", "0?Return()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:12] ExecIf("SIP/100-0000001f", "0?Set(__REC_POLICY_MODE=)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:13] GotoIf("SIP/100-0000001f", "0?exten,1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:14] Set("SIP/100-0000001f", "__REC_STATUS=INITIALIZED") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:15] Set("SIP/100-0000001f", "NOW=1395145322") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:16] Set("SIP/100-0000001f", "__DAY=18") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:17] Set("SIP/100-0000001f", "__MONTH=03") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:18] Set("SIP/100-0000001f", "__YEAR=2014") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:19] Set("SIP/100-0000001f", "__TIMESTR=20140318-162202") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:20] Set("SIP/100-0000001f", "__FROMEXTEN=100") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:21] Set("SIP/100-0000001f", "__CALLFILENAME=exten-101-100-20140318-162202-1395145322.31") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:22] Goto("SIP/100-0000001f", "exten,1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (sub-record-check,exten,1) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/100-0000001f", "0?callee") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "__REC_POLICY_MODE=dontcare") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] GotoIf("SIP/100-0000001f", "1?caller") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (sub-record-check,exten,10) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:10] Set("SIP/100-0000001f", "__REC_POLICY_MODE=dontcare") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:11] GosubIf("SIP/100-0000001f", "0?record,1(exten,101,100)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:12] Return("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:9] GotoIf("SIP/100-0000001f", "1?macrodial") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (macro-exten-vm,s,15) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:15] GosubIf("SIP/100-0000001f", "0?clrheader,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:16] Macro("SIP/100-0000001f", "dial-one,,Ttr,101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "DEXTEN=101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "DIALSTATUS_CW=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] GosubIf("SIP/100-0000001f", "0?screen,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] GosubIf("SIP/100-0000001f", "0?cf,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] GotoIf("SIP/100-0000001f", "1?skip1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (macro-dial-one,s,8) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:8] GotoIf("SIP/100-0000001f", "0?nodial") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:9] GotoIf("SIP/100-0000001f", "0?continue") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:10] Set("SIP/100-0000001f", "EXTHASCW=ENABLED") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:11] GotoIf("SIP/100-0000001f", "0?next1:cwinusebusy") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (macro-dial-one,s,23) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:23] GotoIf("SIP/100-0000001f", "1?next3:continue") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (macro-dial-one,s,24) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:24] ExecIf("SIP/100-0000001f", "0?Set(DIALSTATUS_CW=BUSY)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:25] GotoIf("SIP/100-0000001f", "0?nodial") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:26] GosubIf("SIP/100-0000001f", "1?dstring,1():dlocal,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "DSTRING=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "DEVICES=101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] ExecIf("SIP/100-0000001f", "0?Return()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] ExecIf("SIP/100-0000001f", "0?Set(DEVICES=01)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] Set("SIP/100-0000001f", "LOOPCNT=1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:6] Set("SIP/100-0000001f", "ITER=1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:7] Set("SIP/100-0000001f", "THISDIAL=SIP/101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:8] GosubIf("SIP/100-0000001f", "1?zap2dahdi,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] ExecIf("SIP/100-0000001f", "0?Return()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Set("SIP/100-0000001f", "NEWDIAL=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] Set("SIP/100-0000001f", "LOOPCNT2=1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:4] Set("SIP/100-0000001f", "ITER2=1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:5] Set("SIP/100-0000001f", "THISPART2=SIP/101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:6] ExecIf("SIP/100-0000001f", "0?Set(THISPART2=DAHDI/101)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:7] Set("SIP/100-0000001f", "NEWDIAL=SIP/101&") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:8] Set("SIP/100-0000001f", "ITER2=2") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:9] GotoIf("SIP/100-0000001f", "0?begin2") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:10] Set("SIP/100-0000001f", "THISDIAL=SIP/101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:11] Return("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:9] Set("SIP/100-0000001f", "DSTRING=SIP/101&") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:10] Set("SIP/100-0000001f", "ITER=2") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:11] GotoIf("SIP/100-0000001f", "0?begin") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:12] Set("SIP/100-0000001f", "DSTRING=SIP/101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:13] Return("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:27] GotoIf("SIP/100-0000001f", "0?nodial") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:28] GotoIf("SIP/100-0000001f", "0?skiptrace") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:29] GosubIf("SIP/100-0000001f", "1?ctset,1():ctclear,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "DB(CALLTRACE/101)=100") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Return("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:30] Set("SIP/100-0000001f", "D_OPTIONS=Ttr") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:31] ExecIf("SIP/100-0000001f", "0?SIPAddHeader(Alert-Info: )") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:32] ExecIf("SIP/100-0000001f", "0?SIPAddHeader()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:33] ExecIf("SIP/100-0000001f", "0?Set(CHANNEL(musicclass)=)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:34] GosubIf("SIP/100-0000001f", "0?qwait,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:35] Set("SIP/100-0000001f", "__CWIGNORE=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:36] Set("SIP/100-0000001f", "__KEEPCID=TRUE") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:37] GotoIf("SIP/100-0000001f", "0?usegoto,1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:38] GotoIf("SIP/100-0000001f", "0?godial") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:39] Gosub("SIP/100-0000001f", "sub-presencestate-display,s,1(101)") in new stack [2014-03-18 16:22:02] WARNING[4254][C-0000001c] func_presencestate.c: PRESENCE_STATE unknown [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Goto("SIP/100-0000001f", "state-,1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (sub-presencestate-display,state-,1) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Set("SIP/100-0000001f", "PRESENCESTATE_DISPLAY=") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] Return("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:40] Set("SIP/100-0000001f", "CONNECTEDLINE(name,i)=TEST") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:41] Set("SIP/100-0000001f", "CONNECTEDLINE(num)=101") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:42] Set("SIP/100-0000001f", "D_OPTIONS=TtrI") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:43] Dial("SIP/100-0000001f", "SIP/101,,TtrI") in new stack [2014-03-18 16:22:02] WARNING[4254][C-0000001c] app_dial.c: Unable to create channel of type 'SIP' (cause 20 - Subscriber absent) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] app_dial.c: == Everyone is busy/congested at this time (1:0/0/1) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:44] ExecIf("SIP/100-0000001f", "0?MacroExit()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:45] ExecIf("SIP/100-0000001f", "0?Set(DIALSTATUS=)") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:46] GosubIf("SIP/100-0000001f", "0?s-CHANUNAVAIL,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:47] MacroExit("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:17] Set("SIP/100-0000001f", "SV_DIALSTATUS=CHANUNAVAIL") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:18] GosubIf("SIP/100-0000001f", "0?docfu,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:19] GosubIf("SIP/100-0000001f", "0?docfb,1()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:20] Set("SIP/100-0000001f", "DIALSTATUS=CHANUNAVAIL") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:21] ExecIf("SIP/100-0000001f", "0?MacroExit()") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:22] GotoIf("SIP/100-0000001f", "1?s-CHANUNAVAIL,1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Goto (macro-exten-vm,s-CHANUNAVAIL,1) [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] GotoIf("SIP/100-0000001f", "0?exit,1") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:2] PlayTones("SIP/100-0000001f", "congestion") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:3] Congestion("SIP/100-0000001f", "10") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] app_macro.c: == Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 3) exited non-zero on 'SIP/100-0000001f' in macro 'exten-vm' [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: == Spawn extension (from-internal, 101, 2) exited non-zero on 'SIP/100-0000001f' [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: -- Executing [[email protected]:1] Hangup("SIP/100-0000001f", "") in new stack [2014-03-18 16:22:02] VERBOSE[4254][C-0000001c] pbx.c: == Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/100-0000001f'

Can anybody help me to find the problem? I really need Zoiper softphone as it allows to register multiple accounts in free version and we’re already using it with one provider.

When registering one extension with Zoiper and second one with XLite, I have noticed that I can call from Zoiper to XLite, but I can’t call from XLite to Zoiper.

What does “sip show peers” show?

I can’t say exactly what was output, cause zoiper started working as soon as I changed “Nat” to “yes” for each extension. But now I have another problem. Remote extensions don’t work properly until I place call to them. I mean:

I have one internal network extension. It’s showing registered and working properly. I have 2 other remote extensions. As soon as I oper Zoiper, it shows that extensions are registered, but they can’t call (503 - Service Unavailable), until the moment I first call to them from working internal extension. As soon as I call from internal extension, they get something like “activated”. Any help is appreciated.

sip show peers output now is:

Name/username Host Forcerport Comedia Port Status
100/100 192.168.10.101 Yes Yes 35968 OK(9 ms)
301 (Unspecified) Yes Yes 0 UNKNOWN
302 (Unspecified) Yes Yes 0 UNKNOWN

Extension 100 is local network extension. Extensions 301 and 302 are remote. As soon as I call them first, their ips ports and status are starting to show.