Calls go straight to voicemail

FreePBX
1

hi, i have just put up my first freepbx (13 with current patches) box and we are in test mode. initially, I have 15 grandstream phones attached. I am having an issue and I need some help debugging. What I am seeing is the system seems to work ok for the first couple of hours after a reboot, then at some point, all calls (we are only dialing internally currently) go directly to voicemail. the phones say they are registered and I have a verbose log from one attempt but to be honest, I am not sure how to read it. In this example, 5323 is calling 5339 and the call goes directly to vm…I should also say that these phones are are local to the pbx and are configured to use sip-tls and srtp

any help would be greatly appreciated!

=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2017.03.24 10:07:25 =~=~=~=~=~=~=~=~=~=~=~=

== Setting global variable ‘SIPDOMAIN’ to ‘172.30.2.1’

uepbx1*CLI>
– Executing [5339@from-internal:1] GotoIf(“PJSIP/5323-00000031”, “1?ext-local,5339,1:followme-check,5339,1”) in new stack

uepbx1*CLI>
– Goto (ext-local,5339,1)

uepbx1*CLI>
– Executing [5339@ext-local:1] Set(“PJSIP/5323-00000031”, “__RINGTIMER=15”) in new stack

uepbx1*CLI>
– Executing [5339@ext-local:2] Macro(“PJSIP/5323-00000031”, “exten-vm,5339,5339,0,0,0”) in new stack

uepbx1*CLI>
– Executing [s@macro-exten-vm:1] Macro(“PJSIP/5323-00000031”, “user-callerid,”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:1] Set(“PJSIP/5323-00000031”, “TOUCH_MONITOR=1490364458.59”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:2] Set(“PJSIP/5323-00000031”, “AMPUSER=5323”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/5323-00000031”, “0?report”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:4] ExecIf(“PJSIP/5323-00000031”, “1?Set(REALCALLERIDNUM=5323)”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:5] Set(“PJSIP/5323-00000031”, “AMPUSER=5323”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:6] GotoIf(“PJSIP/5323-00000031”, “0?limit”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:7] Set(“PJSIP/5323-00000031”, “AMPUSERCIDNAME=Tony Guadagno”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:8] GotoIf(“PJSIP/5323-00000031”, “0?report”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:9] Set(“PJSIP/5323-00000031”, “AMPUSERCID=5323”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:10] Set(“PJSIP/5323-00000031”, “__DIAL_OPTIONS=Ttr”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:11] Set(“PJSIP/5323-00000031”, “CALLERID(all)=“Tony Guadagno” <5323>”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:12] GotoIf(“PJSIP/5323-00000031”, “0?limit”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:13] ExecIf(“PJSIP/5323-00000031”, “0?Set(GROUP(concurrency_limit)=5323)”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:14] ExecIf(“PJSIP/5323-00000031”, “0?Set(CHANNEL(language)=)”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:15] GotoIf(“PJSIP/5323-00000031”, “0?continue”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:16] ExecIf(“PJSIP/5323-00000031”, “1?Set(__CALLEE_ACCOUNCODE=)”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:17] Set(“PJSIP/5323-00000031”, “__TTL=64”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:18] GotoIf(“PJSIP/5323-00000031”, “1?continue”) in new stack

uepbx1*CLI>
– Goto (macro-user-callerid,s,29)

uepbx1*CLI>
– Executing [s@macro-user-callerid:29] Set(“PJSIP/5323-00000031”, “CALLERID(number)=5323”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:30] Set(“PJSIP/5323-00000031”, “CALLERID(name)=Tony Guadagno”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:31] GotoIf(“PJSIP/5323-00000031”, “0?cnum”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:32] Set(“PJSIP/5323-00000031”, “CDR(cnam)=Tony Guadagno”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:33] Set(“PJSIP/5323-00000031”, “CDR(cnum)=5323”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:34] Set(“PJSIP/5323-00000031”, “CHANNEL(language)=en”) in new stack

uepbx1*CLI>
– Executing [s@macro-exten-vm:2] Set(“PJSIP/5323-00000031”, “RingGroupMethod=none”) in new stack

uepbx1*CLI>
– Executing [s@macro-exten-vm:3] Set(“PJSIP/5323-00000031”, “__EXTTOCALL=5339”) in new stack

uepbx1*CLI>
– Executing [s@macro-exten-vm:4] Set(“PJSIP/5323-00000031”, “__PICKUPMARK=5339”) in new stack

uepbx1*CLI>
– Executing [s@macro-exten-vm:5] Set(“PJSIP/5323-00000031”, “RT=15”) in new stack

uepbx1*CLI>
[2017-03-24 10:07:38] WARNING[19630][C-0000001a]: chan_sip.c:22827 func_header_read: This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:6] ExecIf(“PJSIP/5323-00000031”, “0?Macro(vm,5339,DIRECTDIAL,)”) in new stack

uepbx1*CLI>
[2017-03-24 10:07:38] WARNING[19630][C-0000001a]: chan_sip.c:22827 func_header_read: This function can only be used on SIP channels.

uepbx1*CLI>
[2017-03-24 10:07:38] WARNING[19630][C-0000001a]: chan_sip.c:22827 func_header_read: This function can only be used on SIP channels.
– Executing [s@macro-exten-vm:7] ExecIf(“PJSIP/5323-00000031”, “0?MacroExit()”) in new stack

uepbx1*CLI>
[2017-03-24 10:07:38] WARNING[19630][C-0000001a]: chan_sip.c:22827 func_header_read: This function can only be used on SIP channels.

uepbx1*CLI>
– Executing [s@macro-exten-vm:8] Gosub(“PJSIP/5323-00000031”, “sub-record-check,s,1(exten,5339,dontcare)”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:1] GotoIf(“PJSIP/5323-00000031”, “0?initialized”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:2] Set(“PJSIP/5323-00000031”, “__REC_STATUS=INITIALIZED”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:3] Set(“PJSIP/5323-00000031”, “NOW=1490364458”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:4] Set(“PJSIP/5323-00000031”, “__DAY=24”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:5] Set(“PJSIP/5323-00000031”, “__MONTH=03”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:6] Set(“PJSIP/5323-00000031”, “__YEAR=2017”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:7] Set(“PJSIP/5323-00000031”, “__TIMESTR=20170324-100738”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:8] Set(“PJSIP/5323-00000031”, “__FROMEXTEN=5323”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:9] Set(“PJSIP/5323-00000031”, “__MON_FMT=wav”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:10] NoOp(“PJSIP/5323-00000031”, “Recordings initialized”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:11] ExecIf(“PJSIP/5323-00000031”, “0?Set(ARG3=dontcare)”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:12] Set(“PJSIP/5323-00000031”, “REC_POLICY_MODE_SAVE=”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:13] ExecIf(“PJSIP/5323-00000031”, “0?Set(REC_STATUS=NO)”) in new stack

uepbx1*CLI>
– Executing [s@sub-record-check:14] GotoIf(“PJSIP/5323-00000031”, “5?checkaction”) in new stack

uepbx1*CLI>
– Goto (sub-record-check,s,17)

uepbx1*CLI>
– Executing [s@sub-record-check:17] GotoIf(“PJSIP/5323-00000031”, “1?sub-record-check,exten,1”) in new stack

uepbx1*CLI>
– Goto (sub-record-check,exten,1)

uepbx1*CLI>
– Executing [exten@sub-record-check:1] NoOp(“PJSIP/5323-00000031”, “Exten Recording Check between 5323 and 5339”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:2] Set(“PJSIP/5323-00000031”, “CALLTYPE=internal”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:3] ExecIf(“PJSIP/5323-00000031”, “0?Set(CALLTYPE=)”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:4] Set(“PJSIP/5323-00000031”, “CALLEE=dontcare”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:5] ExecIf(“PJSIP/5323-00000031”, “0?Set(CALLEE=dontcare)”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:6] GotoIf(“PJSIP/5323-00000031”, “0?callee”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:7] GotoIf(“PJSIP/5323-00000031”, “1?caller”) in new stack

uepbx1*CLI>
– Goto (sub-record-check,exten,13)

uepbx1*CLI>
– Executing [exten@sub-record-check:13] Set(“PJSIP/5323-00000031”, “RECMODE=dontcare”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:14] ExecIf(“PJSIP/5323-00000031”, “0?Set(RECMODE=dontcare)”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:15] ExecIf(“PJSIP/5323-00000031”, “1?Set(RECMODE=dontcare)”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:16] Gosub(“PJSIP/5323-00000031”, “recordcheck,1(dontcare,internal,5339)”) in new stack

uepbx1*CLI>
– Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/5323-00000031”, “Starting recording check against dontcare”) in new stack

uepbx1*CLI>
– Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/5323-00000031”, “dontcare”) in new stack

uepbx1*CLI>
– Goto (sub-record-check,recordcheck,3)

uepbx1*CLI>
– Executing [recordcheck@sub-record-check:3] Return(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [exten@sub-record-check:17] Return(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [s@macro-exten-vm:9] GotoIf(“PJSIP/5323-00000031”, “1?macrodial”) in new stack
– Goto (macro-exten-vm,s,15)
– Executing [s@macro-exten-vm:15] GosubIf(“PJSIP/5323-00000031”, “0?clrheader,1()”) in new stack
– Executing [s@macro-exten-vm:16] Macro(“PJSIP/5323-00000031”, “dial-one,15,Ttr,5339”) in new stack
– Executing [s@macro-dial-one:1] Set(“PJSIP/5323-00000031”, “DEXTEN=5339”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:2] ExecIf(“PJSIP/5323-00000031”, “0?Set(EXTTOCALL=5339)”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:3] Set(“PJSIP/5323-00000031”, “DIALSTATUS_CW=”) in new stack
– Executing [s@macro-dial-one:4] GosubIf(“PJSIP/5323-00000031”, “0?screen,1()”) in new stack
– Executing [s@macro-dial-one:5] GosubIf(“PJSIP/5323-00000031”, “0?cf,1()”) in new stack
– Executing [s@macro-dial-one:6] GotoIf(“PJSIP/5323-00000031”, “1?skip1”) in new stack
– Goto (macro-dial-one,s,9)
– Executing [s@macro-dial-one:9] GotoIf(“PJSIP/5323-00000031”, “0?nodial”) in new stack
– Executing [s@macro-dial-one:10] GotoIf(“PJSIP/5323-00000031”, “0?continue”) in new stack
– Executing [s@macro-dial-one:11] Set(“PJSIP/5323-00000031”, “EXTHASCW=ENABLED”) in new stack
– Executing [s@macro-dial-one:12] GotoIf(“PJSIP/5323-00000031”, “0?next1:cwinusebusy”) in new stack
– Goto (macro-dial-one,s,24)
– Executing [s@macro-dial-one:24] GotoIf(“PJSIP/5323-00000031”, “0?next3:continue”) in new stack
– Goto (macro-dial-one,s,26)
– Executing [s@macro-dial-one:26] GotoIf(“PJSIP/5323-00000031”, “0?nodial”) in new stack
– Executing [s@macro-dial-one:27] GosubIf(“PJSIP/5323-00000031”, “1?dstring,1():dlocal,1()”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:1] Set(“PJSIP/5323-00000031”, “DSTRING=”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:2] Set(“PJSIP/5323-00000031”, “DEVICES=5339”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:3] ExecIf(“PJSIP/5323-00000031”, “0?Return()”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:4] ExecIf(“PJSIP/5323-00000031”, “0?Set(DEVICES=339)”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:5] Set(“PJSIP/5323-00000031”, “LOOPCNT=1”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:6] Set(“PJSIP/5323-00000031”, “ITER=1”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:7] Set(“PJSIP/5323-00000031”, “THISDIAL=PJSIP/5339”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:8] GosubIf(“PJSIP/5323-00000031”, “1?zap2dahdi,1()”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:1] ExecIf(“PJSIP/5323-00000031”, “0?Return()”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:2] Set(“PJSIP/5323-00000031”, “NEWDIAL=”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:3] Set(“PJSIP/5323-00000031”, “LOOPCNT2=1”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:4] Set(“PJSIP/5323-00000031”, “ITER2=1”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:5] Set(“PJSIP/5323-00000031”, “THISPART2=PJSIP/5339”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:6] ExecIf(“PJSIP/5323-00000031”, “0?Set(THISPART2=DAHDIIP/5339)”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:7] Set(“PJSIP/5323-00000031”, “NEWDIAL=PJSIP/5339&”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:8] Set(“PJSIP/5323-00000031”, “ITER2=2”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:9] GotoIf(“PJSIP/5323-00000031”, “0?begin2”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:10] Set(“PJSIP/5323-00000031”, “THISDIAL=PJSIP/5339”) in new stack

uepbx1*CLI>
– Executing [zap2dahdi@macro-dial-one:11] Return(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:9] GotoIf(“PJSIP/5323-00000031”, “0?docheck”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:10] NoOp(“PJSIP/5323-00000031”, “Debug: Found PJSIP Destination PJSIP/5339”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:11] GotoIf(“PJSIP/5323-00000031”, “0?doset”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:12] NoOp(“PJSIP/5323-00000031”, “Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:13] Set(“PJSIP/5323-00000031”, “THISDIAL=PJSIP/5339/sips:[email protected]:40556;transport=TLS”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:14] GotoIf(“PJSIP/5323-00000031”, “0?skipset”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:15] Set(“PJSIP/5323-00000031”, “DSTRING=PJSIP/5339/sips:[email protected]:40556;transport=TLS&”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:16] Set(“PJSIP/5323-00000031”, “ITER=2”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:17] GotoIf(“PJSIP/5323-00000031”, “0?begin”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:18] ExecIf(“PJSIP/5323-00000031”, “0?Return()”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:19] Set(“PJSIP/5323-00000031”, “DSTRING=PJSIP/5339/sips:[email protected]:40556;transport=TLS”) in new stack

uepbx1*CLI>
– Executing [dstring@macro-dial-one:20] Return(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:28] GotoIf(“PJSIP/5323-00000031”, “0?nodial”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:29] GotoIf(“PJSIP/5323-00000031”, “0?skiptrace”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:30] GosubIf(“PJSIP/5323-00000031”, “1?ctset,1():ctclear,1()”) in new stack

uepbx1*CLI>
– Executing [ctset@macro-dial-one:1] Set(“PJSIP/5323-00000031”, “DB(CALLTRACE/5339)=5323”) in new stack

uepbx1*CLI>
– Executing [ctset@macro-dial-one:2] Return(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:31] Set(“PJSIP/5323-00000031”, “D_OPTIONS=Ttr”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:32] NoOp(“PJSIP/5323-00000031”, "Blind Transfer: , Attended Transfer: , User: 5323, Alert Info: ") in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:33] ExecIf(“PJSIP/5323-00000031”, “1?Set(ALERT_INFO=)”) in new stack
– Executing [s@macro-dial-one:34] ExecIf(“PJSIP/5323-00000031”, “0?Set(ALERT_INFO=)”) in new stack
– Executing [s@macro-dial-one:35] ExecIf(“PJSIP/5323-00000031”, “0?Set(ALERT_INFO=)”) in new stack
– Executing [s@macro-dial-one:36] ExecIf(“PJSIP/5323-00000031”, “0?Set(ALERT_INFO=;volume=)”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:37] ExecIf(“PJSIP/5323-00000031”, “0?Set(ALERT_INFO=;volume=)”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:38] GosubIf(“PJSIP/5323-00000031”, “0?func-set-sipheader,s,1(Alert-Info,)”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:39] ExecIf(“PJSIP/5323-00000031”, “0?Set(CHANNEL(musicclass)=)”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:40] GosubIf(“PJSIP/5323-00000031”, “0?qwait,1()”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:41] Set(“PJSIP/5323-00000031”, “__CWIGNORE=”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:42] Set(“PJSIP/5323-00000031”, “__KEEPCID=TRUE”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:43] GotoIf(“PJSIP/5323-00000031”, “0?usegoto,1”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:44] GotoIf(“PJSIP/5323-00000031”, “0?godial”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:45] Gosub(“PJSIP/5323-00000031”, “sub-presencestate-display,s,1(5339)”) in new stack

uepbx1*CLI>
– Executing [s@sub-presencestate-display:1] Goto(“PJSIP/5323-00000031”, “state-not_set,1”) in new stack

uepbx1*CLI>
– Goto (sub-presencestate-display,state-not_set,1)

uepbx1*CLI>
– Executing [state-not_set@sub-presencestate-display:1] Set(“PJSIP/5323-00000031”, “PRESENCESTATE_DISPLAY=”) in new stack

uepbx1*CLI>
– Executing [state-not_set@sub-presencestate-display:2] Return(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:46] Set(“PJSIP/5323-00000031”, “CONNECTEDLINE(name,i)=Adam MacVean”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:47] Set(“PJSIP/5323-00000031”, “CONNECTEDLINE(num)=5339”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:48] Set(“PJSIP/5323-00000031”, “D_OPTIONS=TtrI”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:49] Macro(“PJSIP/5323-00000031”, “dialout-one-predial-hook,”) in new stack

uepbx1*CLI>
– Executing [s@macro-dialout-one-predial-hook:1] MacroExit(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:50] ExecIf(“PJSIP/5323-00000031”, “0?Set(D_OPTIONS=trII)”) in new stack

uepbx1*CLI>
– Executing [s@macro-dial-one:51] Dial(“PJSIP/5323-00000031”, “PJSIP/5339/sips:[email protected]:40556;transport=TLS,15,TtrIb(func-apply-sipheaders^s^1)”) in new stack

uepbx1*CLI>
– PJSIP/5339-00000032 Internal Gosub(func-apply-sipheaders,s,1) start
– Executing [s@func-apply-sipheaders:1] NoOp(“PJSIP/5339-00000032”, “Applying SIP Headers to channel”) in new stack
– Executing [s@func-apply-sipheaders:2] Set(“PJSIP/5339-00000032”, “SIPHEADERKEYS=”) in new stack
– Executing [s@func-apply-sipheaders:3] While(“PJSIP/5339-00000032”, “0”) in new stack
– Jumping to priority 7
– Executing [s@func-apply-sipheaders:8] Return(“PJSIP/5339-00000032”, “”) in new stack
== Spawn extension (from-internal, 5339, 1) exited non-zero on ‘PJSIP/5339-00000032’
– PJSIP/5339-00000032 Internal Gosub(func-apply-sipheaders,s,1) complete GOSUB_RETVAL=

uepbx1*CLI>
– Called PJSIP/5339/sips:[email protected]:40556;transport=TLS

uepbx1*CLI>
– Connected line update to PJSIP/5323-00000031 prevented.

uepbx1*CLI>
== Everyone is busy/congested at this time (1:0/1/0)
– Executing [s@macro-dial-one:52] ExecIf(“PJSIP/5323-00000031”, “0?MacroExit()”) in new stack
– Executing [s@macro-dial-one:53] ExecIf(“PJSIP/5323-00000031”, “0?Set(DIALSTATUS=)”) in new stack
– Executing [s@macro-dial-one:54] GosubIf(“PJSIP/5323-00000031”, “0?s-CONGESTION,1()”) in new stack
– Executing [s@macro-dial-one:55] MacroExit(“PJSIP/5323-00000031”, “”) in new stack
– Executing [s@macro-exten-vm:17] Set(“PJSIP/5323-00000031”, “SV_DIALSTATUS=CONGESTION”) in new stack
– Executing [s@macro-exten-vm:18] GosubIf(“PJSIP/5323-00000031”, “0?docfu,1()”) in new stack
– Executing [s@macro-exten-vm:19] GosubIf(“PJSIP/5323-00000031”, “0?docfb,1()”) in new stack
– Executing [s@macro-exten-vm:20] Set(“PJSIP/5323-00000031”, “DIALSTATUS=CONGESTION”) in new stack
– Executing [s@macro-exten-vm:21] ExecIf(“PJSIP/5323-00000031”, “0?MacroExit()”) in new stack
– Executing [s@macro-exten-vm:22] GotoIf(“PJSIP/5323-00000031”, “0?s-CONGESTION,1”) in new stack
– Executing [s@macro-exten-vm:23] Macro(“PJSIP/5323-00000031”, “vm,5339,CONGESTION,”) in new stack
– Executing [s@macro-vm:1] Macro(“PJSIP/5323-00000031”, “user-callerid,SKIPTTL”) in new stack
– Executing [s@macro-user-callerid:1] Set(“PJSIP/5323-00000031”, “TOUCH_MONITOR=1490364458.59”) in new stack
– Executing [s@macro-user-callerid:2] Set(“PJSIP/5323-00000031”, “AMPUSER=5323”) in new stack
– Executing [s@macro-user-callerid:3] GotoIf(“PJSIP/5323-00000031”, “13?report”) in new stack
– Goto (macro-user-callerid,s,15)
– Executing [s@macro-user-callerid:15] GotoIf(“PJSIP/5323-00000031”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,29)
– Executing [s@macro-user-callerid:29] Set(“PJSIP/5323-00000031”, “CALLERID(number)=5323”) in new stack
– Executing [s@macro-user-callerid:30] Set(“PJSIP/5323-00000031”, “CALLERID(name)=Tony Guadagno”) in new stack
– Executing [s@macro-user-callerid:31] GotoIf(“PJSIP/5323-00000031”, “0?cnum”) in new stack
– Executing [s@macro-user-callerid:32] Set(“PJSIP/5323-00000031”, “CDR(cnam)=Tony Guadagno”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:33] Set(“PJSIP/5323-00000031”, “CDR(cnum)=5323”) in new stack

uepbx1*CLI>
– Executing [s@macro-user-callerid:34] Set(“PJSIP/5323-00000031”, “CHANNEL(language)=en”) in new stack

uepbx1*CLI>
– Executing [s@macro-vm:2] Set(“PJSIP/5323-00000031”, “VMGAIN=”) in new stack

uepbx1*CLI>
– Executing [s@macro-vm:3] Macro(“PJSIP/5323-00000031”, “blkvm-check,”) in new stack

uepbx1*CLI>
– Executing [s@macro-blkvm-check:1] Set(“PJSIP/5323-00000031”, “GOSUB_RETVAL=”) in new stack

uepbx1*CLI>
– Executing [s@macro-blkvm-check:2] ExecIf(“PJSIP/5323-00000031”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack

uepbx1*CLI>
– Executing [s@macro-blkvm-check:3] MacroExit(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [s@macro-vm:4] GotoIf(“PJSIP/5323-00000031”, “1?vmx,1”) in new stack

uepbx1*CLI>
– Goto (macro-vm,vmx,1)

uepbx1*CLI>
– Executing [vmx@macro-vm:1] Set(“PJSIP/5323-00000031”, “MEXTEN=5339”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:2] Set(“PJSIP/5323-00000031”, “MMODE=CONGESTION”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:3] Set(“PJSIP/5323-00000031”, “RETVM=”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:4] Set(“PJSIP/5323-00000031”, “MODE=unavail”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:5] Macro(“PJSIP/5323-00000031”, “get-vmcontext,5339”) in new stack

uepbx1*CLI>
– Executing [s@macro-get-vmcontext:1] Set(“PJSIP/5323-00000031”, “VMCONTEXT=default”) in new stack

uepbx1*CLI>
– Executing [s@macro-get-vmcontext:2] GotoIf(“PJSIP/5323-00000031”, “0?200:300”) in new stack

uepbx1*CLI>
– Goto (macro-get-vmcontext,s,300)

uepbx1*CLI>
– Executing [s@macro-get-vmcontext:300] NoOp(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:6] Set(“PJSIP/5323-00000031”, “MODE=unavail”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:7] NoOp(“PJSIP/5323-00000031”, “MODE IS: unavail”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:8] GotoIf(“PJSIP/5323-00000031”, “1?chknomsg”) in new stack

uepbx1*CLI>
– Goto (macro-vm,vmx,10)

uepbx1*CLI>
– Executing [vmx@macro-vm:10] GotoIf(“PJSIP/5323-00000031”, “0?s-CONGESTION,1”) in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:11] GotoIf(“PJSIP/5323-00000031”, “1?notdirect”) in new stack

uepbx1*CLI>
– Goto (macro-vm,vmx,13)

uepbx1*CLI>
– Executing [vmx@macro-vm:13] NoOp(“PJSIP/5323-00000031”, "Checking if ext 5339 is enabled: ") in new stack

uepbx1*CLI>
– Executing [vmx@macro-vm:14] GotoIf(“PJSIP/5323-00000031”, “1?s-CONGESTION,1”) in new stack

uepbx1*CLI>
– Goto (macro-vm,s-CONGESTION,1)

uepbx1*CLI>
– Executing [s-CONGESTION@macro-vm:1] Macro(“PJSIP/5323-00000031”, “get-vmcontext,5339”) in new stack

uepbx1*CLI>
– Executing [s@macro-get-vmcontext:1] Set(“PJSIP/5323-00000031”, “VMCONTEXT=default”) in new stack

uepbx1*CLI>
– Executing [s@macro-get-vmcontext:2] GotoIf(“PJSIP/5323-00000031”, “0?200:300”) in new stack

uepbx1*CLI>
– Goto (macro-get-vmcontext,s,300)

uepbx1*CLI>
– Executing [s@macro-get-vmcontext:300] NoOp(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
– Executing [s-CONGESTION@macro-vm:2] VoiceMail(“PJSIP/5323-00000031”, “5339@default,u”) in new stack

uepbx1*CLI>
– <PJSIP/5323-00000031> Playing ‘/var/spool/asterisk/voicemail/default/5339/greet.slin’ (language ‘en’)

uepbx1*CLI>
– <PJSIP/5323-00000031> Playing ‘vm-isunavail.ulaw’ (language ‘en’)

uepbx1*CLI>
– <PJSIP/5323-00000031> Playing ‘vm-intro.ulaw’ (language ‘en’)

uepbx1*CLI>
== Spawn extension (macro-vm, s-CONGESTION, 2) exited non-zero on ‘PJSIP/5323-00000031’ in macro ‘vm’

uepbx1*CLI>
== Spawn extension (macro-exten-vm, s, 23) exited non-zero on ‘PJSIP/5323-00000031’ in macro ‘exten-vm’

uepbx1*CLI>
== Spawn extension (ext-local, 5339, 2) exited non-zero on ‘PJSIP/5323-00000031’

uepbx1*CLI>
– Executing [h@ext-local:1] Macro(“PJSIP/5323-00000031”, “hangupcall,”) in new stack

uepbx1*CLI>
– Executing [s@macro-hangupcall:1] GotoIf(“PJSIP/5323-00000031”, “1?theend”) in new stack

uepbx1*CLI>
– Goto (macro-hangupcall,s,3)

uepbx1*CLI>
– Executing [s@macro-hangupcall:3] ExecIf(“PJSIP/5323-00000031”, “0?Set(CDR(recordingfile)=)”) in new stack

uepbx1*CLI>
– Executing [s@macro-hangupcall:4] Hangup(“PJSIP/5323-00000031”, “”) in new stack

uepbx1*CLI>
== Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘PJSIP/5323-00000031’ in macro ‘hangupcall’

uepbx1*CLI>
== Spawn extension (ext-local, h, 1) exited non-zero on ‘PJSIP/5323-00000031’

uepbx1*CLI>

2

update

this is a learning process for me, as I have been poking around, I think I am getting closer to the problem. all my phones have 2 accounts (extensions) for example, 5339(primary) and 7339. it seems that all my 5xxx extensions are unavailable yet (on the same phone) the 7xxx extensions are available…if anyone could point me in the right direction, I would appreciate it.

thanks

> uepbx1*CLI> pjsip show contacts

>   Contact:  <Aor/ContactUri..............................> <Hash....> <Status> <RTT(ms)..>
> ==========================================================================================

>   Contact:  5002/sips:[email protected]:40802;transport=TLS 6094490057 Unavail       0.000
>   Contact:  5036/sips:[email protected]:52172;transport=TLS 251c134816 Unavail       0.000
>   Contact:  5323/sips:[email protected]:40881;transport=TLS 472004354e Unavail       0.000
>   Contact:  5332/sips:[email protected]:32943;transport=TLS e8ac64e973 Unavail       0.000
>   Contact:  5338/sips:[email protected]:50715;transport=TLS 4b22994135 Unavail       0.000
>   Contact:  5339/sips:[email protected]:40556;transport=TLS 711b1850d6 Unavail       0.000
>   Contact:  5356/sips:[email protected]:46774;transport=TLS ab0fc02f3c Unavail       0.000
>   Contact:  5357/sips:[email protected]:43609;transport=TLS 7f30fbe13a Unavail       0.000
>   Contact:  5375/sips:[email protected]:40240;transport=TLS 19e8e594fd Unavail       0.000
>   Contact:  7002/sips:[email protected]:41122;transport=TLS bf147876e9 Avail        10.265
>   Contact:  7036/sips:[email protected]:52353;transport=TLS 1325174383 Avail         8.154
>   Contact:  7323/sips:[email protected]:41028;transport=TLS a9c3fff8aa Avail         9.594
>   Contact:  7332/sips:[email protected]:32949;transport=TLS 52420a06a1 Avail        10.486
>   Contact:  7338/sips:[email protected]:50947;transport=TLS ef45dd265f Avail         8.947
>   Contact:  7339/sips:[email protected]:40795;transport=TLS 3626340953 Avail        16.233
>   Contact:  7356/sips:[email protected]:47082;transport=TLS ee106e1211 Avail         7.949
>   Contact:  7357/sips:[email protected]:43869;transport=TLS 4c3d630a06 Avail        11.407
>   Contact:  7375/sips:[email protected]:40414;transport=TLS c46e413763 Avail         8.922