PJSIP Error with NO PJSIP configured

sip set debug peer xxxx

Thats the information I pasted above.
I run asterisk, type that in and get of course all the other extensions noise, plus the debug stuff which was what I pasted.
Is there away to get rid of the rest of the asterisk info not related to the specific call?

asterisk -r

then

sip set debug peer xxxx

If you are not getting anything but the SIP Options message, then the call you are trying to make doesn’t reach the server.
Are you doing the debug on the calling or the called extension?

If I use only asterisk -r then sip debug I get only this:

[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
[2018-07-06 18:31:47] ERROR[12590][C-0000089d]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered</code>

If I load asrterisk -rvvv, the sip debug I get this, hopefully not too much extra is here. 1111111111 is the caller, 2222222222 is the DID being called, 522 is the extension number in question.

[2018-07-06 18:34:54] NOTICE[4949]: chan_sip.c:28461 handle_request_subscribe: Received SIP subscribe for peer without mailbox: 508
  == Using SIP RTP TOS bits 184
  == Using SIP RTP CoS mark 5
    -- Executing [2222222222@from-trunk:1] Set("SIP/IISG-IN-2-0000191e", "__DIRECTION=INBOUND") in new stack
    -- Executing [2222222222@from-trunk:2] Gosub("SIP/IISG-IN-2-0000191e", "sub-record-check,s,1(in,2222222222,dontcare)") in new stack
    -- Executing [s@sub-record-check:1] GotoIf("SIP/IISG-IN-2-0000191e", "0?initialized") in new stack
    -- Executing [s@sub-record-check:2] Set("SIP/IISG-IN-2-0000191e", "__REC_STATUS=INITIALIZED") in new stack
    -- Executing [s@sub-record-check:3] Set("SIP/IISG-IN-2-0000191e", "NOW=1530920094") in new stack
    -- Executing [s@sub-record-check:4] Set("SIP/IISG-IN-2-0000191e", "__DAY=06") in new stack
    -- Executing [s@sub-record-check:5] Set("SIP/IISG-IN-2-0000191e", "__MONTH=07") in new stack
    -- Executing [s@sub-record-check:6] Set("SIP/IISG-IN-2-0000191e", "__YEAR=2018") in new stack
    -- Executing [s@sub-record-check:7] Set("SIP/IISG-IN-2-0000191e", "__TIMESTR=20180706-183454") in new stack
    -- Executing [s@sub-record-check:8] Set("SIP/IISG-IN-2-0000191e", "__FROMEXTEN=unknown") in new stack
    -- Executing [s@sub-record-check:9] Set("SIP/IISG-IN-2-0000191e", "__MON_FMT=wav") in new stack
    -- Executing [s@sub-record-check:10] NoOp("SIP/IISG-IN-2-0000191e", "Recordings initialized") in new stack
    -- Executing [s@sub-record-check:11] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(ARG3=dontcare)") in new stack
    -- Executing [s@sub-record-check:12] Set("SIP/IISG-IN-2-0000191e", "REC_POLICY_MODE_SAVE=") in new stack
    -- Executing [s@sub-record-check:13] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(REC_STATUS=NO)") in new stack
    -- Executing [s@sub-record-check:14] GotoIf("SIP/IISG-IN-2-0000191e", "2?checkaction") in new stack
    -- Goto (sub-record-check,s,17)
    -- Executing [s@sub-record-check:17] GotoIf("SIP/IISG-IN-2-0000191e", "1?sub-record-check,in,1") in new stack
    -- Goto (sub-record-check,in,1)
    -- Executing [in@sub-record-check:1] NoOp("SIP/IISG-IN-2-0000191e", "Inbound Recording Check to 2222222222") in new stack
    -- Executing [in@sub-record-check:2] Set("SIP/IISG-IN-2-0000191e", "FROMEXTEN=unknown") in new stack
    -- Executing [in@sub-record-check:3] ExecIf("SIP/IISG-IN-2-0000191e", "11?Set(FROMEXTEN=11111111111)") in new stack
    -- Executing [in@sub-record-check:4] Gosub("SIP/IISG-IN-2-0000191e", "recordcheck,1(dontcare,in,2222222222)") in new stack
    -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/IISG-IN-2-0000191e", "Starting recording check against dontcare") in new stack
    -- Executing [recordcheck@sub-record-check:2] Goto("SIP/IISG-IN-2-0000191e", "dontcare") in new stack
    -- Goto (sub-record-check,recordcheck,3)
    -- Executing [recordcheck@sub-record-check:3] Return("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [in@sub-record-check:5] Return("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [2222222222@from-trunk:3] Set("SIP/IISG-IN-2-0000191e", "CHANNEL(tonezone)=us") in new stack
    -- Executing [2222222222@from-trunk:4] Set("SIP/IISG-IN-2-0000191e", "__FROM_DID=2222222222") in new stack
    -- Executing [2222222222@from-trunk:5] Set("SIP/IISG-IN-2-0000191e", "returnhere=1") in new stack
    -- Executing [2222222222@from-trunk:6] Gosub("SIP/IISG-IN-2-0000191e", "app-blacklist-check,s,1()") in new stack
    -- Executing [s@app-blacklist-check:1] GotoIf("SIP/IISG-IN-2-0000191e", "0?blacklisted") in new stack
    -- Executing [s@app-blacklist-check:2] Set("SIP/IISG-IN-2-0000191e", "CALLED_BLACKLIST=1") in new stack
    -- Executing [s@app-blacklist-check:3] Return("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [2222222222@from-trunk:7] Set("SIP/IISG-IN-2-0000191e", "CDR(did)=2222222222") in new stack
    -- Executing [2222222222@from-trunk:8] GotoIf("SIP/IISG-IN-2-0000191e", "0?") in new stack
    -- Executing [2222222222@from-trunk:9] ExecIf("SIP/IISG-IN-2-0000191e", "0 ?Set(CALLERID(name)=11111111111)") in new stack
    -- Executing [2222222222@from-trunk:10] Set("SIP/IISG-IN-2-0000191e", "__MOHCLASS=") in new stack
    -- Executing [2222222222@from-trunk:11] Set("SIP/IISG-IN-2-0000191e", "__REVERSAL_REJECT=FALSE") in new stack
    -- Executing [2222222222@from-trunk:12] GotoIf("SIP/IISG-IN-2-0000191e", "1?post-reverse-charge") in new stack
    -- Goto (from-trunk,2222222222,14)
    -- Executing [2222222222@from-trunk:14] NoOp("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [2222222222@from-trunk:15] Set("SIP/IISG-IN-2-0000191e", "__CALLINGNAMEPRES_SV=allowed_not_screened") in new stack
    -- Executing [2222222222@from-trunk:16] Set("SIP/IISG-IN-2-0000191e", "__CALLINGNUMPRES_SV=allowed_not_screened") in new stack
    -- Executing [2222222222@from-trunk:17] Set("SIP/IISG-IN-2-0000191e", "CALLERID(name-pres)=allowed_not_screened") in new stack
    -- Executing [2222222222@from-trunk:18] Set("SIP/IISG-IN-2-0000191e", "CALLERID(num-pres)=allowed_not_screened") in new stack
    -- Executing [2222222222@from-trunk:19] NoOp("SIP/IISG-IN-2-0000191e", "CallerID Entry Point") in new stack
    -- Executing [2222222222@from-trunk:20] Goto("SIP/IISG-IN-2-0000191e", "from-did-direct,522,1") in new stack
    -- Goto (from-did-direct,522,1)
    -- Executing [522@from-did-direct:1] GotoIf("SIP/IISG-IN-2-0000191e", "1?ext-local,522,1:followme-check,522,1") in new stack
    -- Goto (ext-local,522,1)
    -- Executing [522@ext-local:1] Set("SIP/IISG-IN-2-0000191e", "__RINGTIMER=15") in new stack
    -- Executing [522@ext-local:2] Macro("SIP/IISG-IN-2-0000191e", "exten-vm,522,522,0,0,0") in new stack
    -- Executing [s@macro-exten-vm:1] Macro("SIP/IISG-IN-2-0000191e", "user-callerid,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("SIP/IISG-IN-2-0000191e", "TOUCH_MONITOR=1530920094.6712") in new stack
    -- Executing [s@macro-user-callerid:2] Set("SIP/IISG-IN-2-0000191e", "AMPUSER=11111111111") in new stack
    -- Executing [s@macro-user-callerid:3] GotoIf("SIP/IISG-IN-2-0000191e", "0?report") in new stack
    -- Executing [s@macro-user-callerid:4] ExecIf("SIP/IISG-IN-2-0000191e", "1?Set(REALCALLERIDNUM=11111111111)") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/IISG-IN-2-0000191e", "AMPUSER=") in new stack
    -- Executing [s@macro-user-callerid:6] GotoIf("SIP/IISG-IN-2-0000191e", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/IISG-IN-2-0000191e", "AMPUSERCIDNAME=") in new stack
    -- Executing [s@macro-user-callerid:8] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    -- Executing [s@macro-user-callerid:9] GotoIf("SIP/IISG-IN-2-0000191e", "1?report") in new stack
    -- Goto (macro-user-callerid,s,16)
    -- Executing [s@macro-user-callerid:16] NoOp("SIP/IISG-IN-2-0000191e", "Macro Depth is 2") in new stack
    -- Executing [s@macro-user-callerid:17] GotoIf("SIP/IISG-IN-2-0000191e", "1?report2:macroerror") in new stack
    -- Goto (macro-user-callerid,s,18)
    -- Executing [s@macro-user-callerid:18] GotoIf("SIP/IISG-IN-2-0000191e", "0?continue") in new stack
    -- Executing [s@macro-user-callerid:19] ExecIf("SIP/IISG-IN-2-0000191e", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
    -- Executing [s@macro-user-callerid:20] Set("SIP/IISG-IN-2-0000191e", "__TTL=64") in new stack
    -- Executing [s@macro-user-callerid:21] GotoIf("SIP/IISG-IN-2-0000191e", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,37)
    -- Executing [s@macro-user-callerid:37] Set("SIP/IISG-IN-2-0000191e", "CALLERID(number)=11111111111") in new stack
    -- Executing [s@macro-user-callerid:38] Set("SIP/IISG-IN-2-0000191e", "CALLERID(name)=CallerID") in new stack
    -- Executing [s@macro-user-callerid:39] GotoIf("SIP/IISG-IN-2-0000191e", "0?cnum") in new stack
    -- Executing [s@macro-user-callerid:40] Set("SIP/IISG-IN-2-0000191e", "CDR(cnam)=CallerID") in new stack
    -- Executing [s@macro-user-callerid:41] Set("SIP/IISG-IN-2-0000191e", "CDR(cnum)=11111111111") in new stack
    -- Executing [s@macro-user-callerid:42] Set("SIP/IISG-IN-2-0000191e", "CHANNEL(language)=en") in new stack
    -- Executing [s@macro-exten-vm:2] Set("SIP/IISG-IN-2-0000191e", "RingGroupMethod=none") in new stack
    -- Executing [s@macro-exten-vm:3] Set("SIP/IISG-IN-2-0000191e", "__EXTTOCALL=522") in new stack
    -- Executing [s@macro-exten-vm:4] Set("SIP/IISG-IN-2-0000191e", "__PICKUPMARK=522") in new stack
    -- Executing [s@macro-exten-vm:5] Set("SIP/IISG-IN-2-0000191e", "RT=15") in new stack
    -- Executing [s@macro-exten-vm:6] ExecIf("SIP/IISG-IN-2-0000191e", "0?Macro(vm,522,DIRECTDIAL,)") in new stack
    -- Executing [s@macro-exten-vm:7] ExecIf("SIP/IISG-IN-2-0000191e", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:8] ExecIf("SIP/IISG-IN-2-0000191e", "0?Gosub(ext-intercom,*80522,1())") in new stack
    -- Executing [s@macro-exten-vm:9] ExecIf("SIP/IISG-IN-2-0000191e", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:10] ExecIf("SIP/IISG-IN-2-0000191e", "0?ChanSpy(SIP/522,q)") in new stack
    -- Executing [s@macro-exten-vm:11] ExecIf("SIP/IISG-IN-2-0000191e", "0?MacroExit()") in new stack
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
    -- Executing [s@macro-exten-vm:12] ExecIf("SIP/IISG-IN-2-0000191e", "0?Macro(vm,522,DIRECTDIAL,)") in new stack
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
    -- Executing [s@macro-exten-vm:13] ExecIf("SIP/IISG-IN-2-0000191e", "0?MacroExit()") in new stack
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
    -- Executing [s@macro-exten-vm:14] ExecIf("SIP/IISG-IN-2-0000191e", "0?Gosub(ext-intercom,*80522,1())") in new stack
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
    -- Executing [s@macro-exten-vm:15] ExecIf("SIP/IISG-IN-2-0000191e", "0?MacroExit()") in new stack
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
    -- Executing [s@macro-exten-vm:16] ExecIf("SIP/IISG-IN-2-0000191e", "0?ChanSpy(SIP/522,q)") in new stack
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:608 ast_func_read: Function PJSIP_HEADER not registered
    -- Executing [s@macro-exten-vm:17] ExecIf("SIP/IISG-IN-2-0000191e", "0?MacroExit()") in new stack
[2018-07-06 18:34:54] ERROR[13054][C-000008a3]: pbx_functions.c:651 ast_func_read2: Function PJSIP_HEADER not registered
    -- Executing [s@macro-exten-vm:18] Gosub("SIP/IISG-IN-2-0000191e", "sub-record-check,s,1(exten,522,dontcare)") in new stack
    -- Executing [s@sub-record-check:1] GotoIf("SIP/IISG-IN-2-0000191e", "11?initialized") in new stack
    -- Goto (sub-record-check,s,10)
    -- Executing [s@sub-record-check:10] NoOp("SIP/IISG-IN-2-0000191e", "Recordings initialized") in new stack
    -- Executing [s@sub-record-check:11] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(ARG3=dontcare)") in new stack
    -- Executing [s@sub-record-check:12] Set("SIP/IISG-IN-2-0000191e", "REC_POLICY_MODE_SAVE=") in new stack
    -- Executing [s@sub-record-check:13] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(REC_STATUS=NO)") in new stack
    -- Executing [s@sub-record-check:14] GotoIf("SIP/IISG-IN-2-0000191e", "5?checkaction") in new stack
    -- Goto (sub-record-check,s,17)
    -- Executing [s@sub-record-check:17] GotoIf("SIP/IISG-IN-2-0000191e", "1?sub-record-check,exten,1") in new stack
    -- Goto (sub-record-check,exten,1)
    -- Executing [exten@sub-record-check:1] NoOp("SIP/IISG-IN-2-0000191e", "Exten Recording Check between 11111111111 and 522") in new stack
    -- Executing [exten@sub-record-check:2] Set("SIP/IISG-IN-2-0000191e", "CALLTYPE=external") in new stack
    -- Executing [exten@sub-record-check:3] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(CALLTYPE=)") in new stack
    -- Executing [exten@sub-record-check:4] Set("SIP/IISG-IN-2-0000191e", "CALLEE=dontcare") in new stack
    -- Executing [exten@sub-record-check:5] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(CALLEE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:6] GotoIf("SIP/IISG-IN-2-0000191e", "1?callee") in new stack
    -- Goto (sub-record-check,exten,11)
    -- Executing [exten@sub-record-check:11] Gosub("SIP/IISG-IN-2-0000191e", "recordcheck,1(dontcare,external,522)") in new stack
    -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/IISG-IN-2-0000191e", "Starting recording check against dontcare") in new stack
    -- Executing [recordcheck@sub-record-check:2] Goto("SIP/IISG-IN-2-0000191e", "dontcare") in new stack
    -- Goto (sub-record-check,recordcheck,3)
    -- Executing [recordcheck@sub-record-check:3] Return("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [exten@sub-record-check:12] Return("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [s@macro-exten-vm:19] GotoIf("SIP/IISG-IN-2-0000191e", "1?macrodial") in new stack
    -- Goto (macro-exten-vm,s,25)
    -- Executing [s@macro-exten-vm:25] GosubIf("SIP/IISG-IN-2-0000191e", "0?clrheader,1()") in new stack
    -- Executing [s@macro-exten-vm:26] Macro("SIP/IISG-IN-2-0000191e", "dial-one,15,HhTtr,522") in new stack
    -- Executing [s@macro-dial-one:1] Set("SIP/IISG-IN-2-0000191e", "DEXTEN=522") in new stack
    -- Executing [s@macro-dial-one:2] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(__EXTTOCALL=522)") in new stack
    -- Executing [s@macro-dial-one:3] Set("SIP/IISG-IN-2-0000191e", "DIALSTATUS_CW=") in new stack
    -- Executing [s@macro-dial-one:4] GosubIf("SIP/IISG-IN-2-0000191e", "0?screen,1()") in new stack
    -- Executing [s@macro-dial-one:5] GosubIf("SIP/IISG-IN-2-0000191e", "0?cf,1()") in new stack
    -- Executing [s@macro-dial-one:6] GotoIf("SIP/IISG-IN-2-0000191e", "0?skip1") in new stack
    -- Executing [s@macro-dial-one:7] Set("SIP/IISG-IN-2-0000191e", "DEXTEN=") in new stack
    -- Executing [s@macro-dial-one:8] Set("SIP/IISG-IN-2-0000191e", "DIALSTATUS=BUSY") in new stack
    -- Executing [s@macro-dial-one:9] GotoIf("SIP/IISG-IN-2-0000191e", "1?nodial") in new stack
    -- Goto (macro-dial-one,s,59)
    -- Executing [s@macro-dial-one:59] NoOp("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [s@macro-dial-one:60] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(DIALSTATUS=NOANSWER)") in new stack
    -- Executing [s@macro-dial-one:61] NoOp("SIP/IISG-IN-2-0000191e", "Returned from dial-one with nothing to call and DIALSTATUS: BUSY") in new stack
    -- Executing [s@macro-dial-one:62] MacroExit("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [s@macro-exten-vm:27] Set("SIP/IISG-IN-2-0000191e", "SV_DIALSTATUS=BUSY") in new stack
    -- Executing [s@macro-exten-vm:28] GosubIf("SIP/IISG-IN-2-0000191e", "0?docfu,1()") in new stack
    -- Executing [s@macro-exten-vm:29] GosubIf("SIP/IISG-IN-2-0000191e", "0?docfb,1()") in new stack
    -- Executing [s@macro-exten-vm:30] Set("SIP/IISG-IN-2-0000191e", "DIALSTATUS=BUSY") in new stack
    -- Executing [s@macro-exten-vm:31] ExecIf("SIP/IISG-IN-2-0000191e", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:32] GotoIf("SIP/IISG-IN-2-0000191e", "0?s-BUSY,1") in new stack
    -- Executing [s@macro-exten-vm:33] Macro("SIP/IISG-IN-2-0000191e", "vm,522,BUSY,") in new stack
    -- Executing [s@macro-vm:1] Macro("SIP/IISG-IN-2-0000191e", "user-callerid,SKIPTTL") in new stack
    -- Executing [s@macro-user-callerid:1] Set("SIP/IISG-IN-2-0000191e", "TOUCH_MONITOR=1530920094.6712") in new stack
    -- Executing [s@macro-user-callerid:2] Set("SIP/IISG-IN-2-0000191e", "AMPUSER=11111111111") in new stack
    -- Executing [s@macro-user-callerid:3] GotoIf("SIP/IISG-IN-2-0000191e", "0?report") in new stack
    -- Executing [s@macro-user-callerid:4] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(REALCALLERIDNUM=11111111111)") in new stack
    -- Executing [s@macro-user-callerid:5] Set("SIP/IISG-IN-2-0000191e", "AMPUSER=") in new stack
    -- Executing [s@macro-user-callerid:6] GotoIf("SIP/IISG-IN-2-0000191e", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:7] Set("SIP/IISG-IN-2-0000191e", "AMPUSERCIDNAME=") in new stack
    -- Executing [s@macro-user-callerid:8] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    -- Executing [s@macro-user-callerid:9] GotoIf("SIP/IISG-IN-2-0000191e", "1?report") in new stack
    -- Goto (macro-user-callerid,s,16)
    -- Executing [s@macro-user-callerid:16] NoOp("SIP/IISG-IN-2-0000191e", "Macro Depth is 3") in new stack
    -- Executing [s@macro-user-callerid:17] GotoIf("SIP/IISG-IN-2-0000191e", "1?report2:macroerror") in new stack
    -- Goto (macro-user-callerid,s,18)
    -- Executing [s@macro-user-callerid:18] GotoIf("SIP/IISG-IN-2-0000191e", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,37)
    -- Executing [s@macro-user-callerid:37] Set("SIP/IISG-IN-2-0000191e", "CALLERID(number)=11111111111") in new stack
    -- Executing [s@macro-user-callerid:38] Set("SIP/IISG-IN-2-0000191e", "CALLERID(name)=CallerID") in new stack
    -- Executing [s@macro-user-callerid:39] GotoIf("SIP/IISG-IN-2-0000191e", "0?cnum") in new stack
    -- Executing [s@macro-user-callerid:40] Set("SIP/IISG-IN-2-0000191e", "CDR(cnam)=CallerID") in new stack
    -- Executing [s@macro-user-callerid:41] Set("SIP/IISG-IN-2-0000191e", "CDR(cnum)=11111111111") in new stack
    -- Executing [s@macro-user-callerid:42] Set("SIP/IISG-IN-2-0000191e", "CHANNEL(language)=en") in new stack
    -- Executing [s@macro-vm:2] Set("SIP/IISG-IN-2-0000191e", "VMGAIN=g(12)") in new stack
    -- Executing [s@macro-vm:3] Macro("SIP/IISG-IN-2-0000191e", "blkvm-check,") in new stack
    -- Executing [s@macro-blkvm-check:1] Set("SIP/IISG-IN-2-0000191e", "GOSUB_RETVAL=") in new stack
    -- Executing [s@macro-blkvm-check:2] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(GOSUB_RETVAL=TRUE)") in new stack
    -- Executing [s@macro-blkvm-check:3] MacroExit("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [s@macro-vm:4] GotoIf("SIP/IISG-IN-2-0000191e", "1?vmx,1") in new stack
    -- Goto (macro-vm,vmx,1)
    -- Executing [vmx@macro-vm:1] Set("SIP/IISG-IN-2-0000191e", "MEXTEN=522") in new stack
    -- Executing [vmx@macro-vm:2] Set("SIP/IISG-IN-2-0000191e", "MMODE=BUSY") in new stack
    -- Executing [vmx@macro-vm:3] Set("SIP/IISG-IN-2-0000191e", "RETVM=") in new stack
    -- Executing [vmx@macro-vm:4] Set("SIP/IISG-IN-2-0000191e", "MODE=busy") in new stack
    -- Executing [vmx@macro-vm:5] Macro("SIP/IISG-IN-2-0000191e", "get-vmcontext,522") in new stack
    -- Executing [s@macro-get-vmcontext:1] Set("SIP/IISG-IN-2-0000191e", "VMCONTEXT=default") in new stack
    -- Executing [s@macro-get-vmcontext:2] GotoIf("SIP/IISG-IN-2-0000191e", "0?200:300") in new stack
    -- Goto (macro-get-vmcontext,s,300)
    -- Executing [s@macro-get-vmcontext:300] NoOp("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [vmx@macro-vm:6] Set("SIP/IISG-IN-2-0000191e", "MODE=busy") in new stack
    -- Executing [vmx@macro-vm:7] NoOp("SIP/IISG-IN-2-0000191e", "MODE IS: busy") in new stack
    -- Executing [vmx@macro-vm:8] GotoIf("SIP/IISG-IN-2-0000191e", "1?chknomsg") in new stack
    -- Goto (macro-vm,vmx,10)
    -- Executing [vmx@macro-vm:10] GotoIf("SIP/IISG-IN-2-0000191e", "0?s-BUSY,1") in new stack
    -- Executing [vmx@macro-vm:11] GotoIf("SIP/IISG-IN-2-0000191e", "1?notdirect") in new stack
    -- Goto (macro-vm,vmx,13)
    -- Executing [vmx@macro-vm:13] NoOp("SIP/IISG-IN-2-0000191e", "Checking if ext 522 is enabled: ") in new stack
    -- Executing [vmx@macro-vm:14] GotoIf("SIP/IISG-IN-2-0000191e", "1?s-BUSY,1") in new stack
    -- Goto (macro-vm,s-BUSY,1)
    -- Executing [s-BUSY@macro-vm:1] NoOp("SIP/IISG-IN-2-0000191e", "BUSY voicemail") in new stack
    -- Executing [s-BUSY@macro-vm:2] Macro("SIP/IISG-IN-2-0000191e", "get-vmcontext,522") in new stack
    -- Executing [s@macro-get-vmcontext:1] Set("SIP/IISG-IN-2-0000191e", "VMCONTEXT=default") in new stack
    -- Executing [s@macro-get-vmcontext:2] GotoIf("SIP/IISG-IN-2-0000191e", "0?200:300") in new stack
    -- Goto (macro-get-vmcontext,s,300)
    -- Executing [s@macro-get-vmcontext:300] NoOp("SIP/IISG-IN-2-0000191e", "") in new stack
    -- Executing [s-BUSY@macro-vm:3] VoiceMail("SIP/IISG-IN-2-0000191e", "522@default,bg(12)") in new stack
[2018-07-06 18:34:54] NOTICE[4949]: chan_sip.c:28461 handle_request_subscribe: Received SIP subscribe for peer without mailbox: 509
    -- <SIP/IISG-IN-2-0000191e> Playing '/var/spool/asterisk/voicemail/default/522/busy.slin' (language 'en')
[2018-07-06 18:34:55] NOTICE[4949]: chan_sip.c:28461 handle_request_subscribe: Received SIP subscribe for peer without mailbox: 508
  == Spawn extension (macro-vm, s-BUSY, 3) exited non-zero on 'SIP/IISG-IN-2-0000191e' in macro 'vm'
  == Spawn extension (macro-exten-vm, s, 33) exited non-zero on 'SIP/IISG-IN-2-0000191e' in macro 'exten-vm'
  == Spawn extension (ext-local, 522, 2) exited non-zero on 'SIP/IISG-IN-2-0000191e'
    -- Executing [h@ext-local:1] Macro("SIP/IISG-IN-2-0000191e", "hangupcall,") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("SIP/IISG-IN-2-0000191e", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,3)
    -- Executing [s@macro-hangupcall:3] ExecIf("SIP/IISG-IN-2-0000191e", "0?Set(CDR(recordingfile)=)") in new stack
    -- Executing [s@macro-hangupcall:4] NoOp("SIP/IISG-IN-2-0000191e", " monior file= ") in new stack
    -- Executing [s@macro-hangupcall:5] AGI("SIP/IISG-IN-2-0000191e", "attendedtransfer-rec-restart.php,,") in new stack
    -- Launched AGI Script /var/lib/asterisk/agi-bin/attendedtransfer-rec-restart.php
    -- <SIP/IISG-IN-2-0000191e>AGI Script attendedtransfer-rec-restart.php completed, returning 0
    -- Executing [s@macro-hangupcall:6] Hangup("SIP/IISG-IN-2-0000191e", "") in new stack
  == Spawn extension (macro-hangupcall, s, 6) exited non-zero on 'SIP/IISG-IN-2-0000191e' in macro 'hangupcall'
  == Spawn extension (ext-local, h, 1) exited non-zero on 'SIP/IISG-IN-2-0000191e'
[2018-07-06 18:34:55] NOTICE[4949]: chan_sip.c:28461 handle_request_subscribe: Received SIP subscribe for peer without mailbox: 509

Asterisk thinks 522 is busy, and doesn’t even attempt to dial.

I had seen that after the PJSIP errors and maybe did a bad thing and assume that was the result of the PJSIP issue. I tried to remove all forwards, DND’s etc, but still happens.
I may simply delete and recreate the extension to see if I can force a change.

This topic was automatically closed 365 days after the last reply. New replies are no longer allowed.