Innovaphone 111 can call, but can't be called

pge · May 5, 2022, 6:19pm

Here’s a call with ramped up verbosity:

<--- Transmitting SIP request (418 bytes) to UDP:10.200.20.89:5060 --->
OPTIONS sip:[email protected]:5060 SIP/2.0
Via: SIP/2.0/UDP 10.200.20.5:5060;rport;branch=z9hG4bKPj26a83f2c-c67f-44ff-ba97-0f7b247d746b
From: <sip:[email protected]>;tag=281223a3-42bb-4a2c-9f43-dacf10f7dd49
To: <sip:[email protected]>
Contact: <sip:[email protected]:5060>
Call-ID: f069a8af-595e-44c3-8a24-199f92391b13
CSeq: 48286 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.17.55(16.20.0)
Content-Length:  0


<--- Transmitting SIP request (497 bytes) to TCP:159.65.186.176:26505 --->
OPTIONS sip:[email protected]:26505;transport=TCP;rinstance=18954785 SIP/2.0
Via: SIP/2.0/TCP 212.95.115.1:5060;rport;branch=z9hG4bKPj5e133fe6-9879-4952-8b01-f28c3c06e1fd;alias
From: <sip:[email protected]>;tag=d497eb91-d82c-4a43-bf97-8b2dd8c86ba7
To: <sip:[email protected];rinstance=18954785>
Contact: <sip:[email protected]:5060;transport=TCP>
Call-ID: 22cead31-8157-43c8-b499-139e72fbf5bc
CSeq: 13929 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.17.55(16.20.0)
Content-Length:  0


<--- Transmitting SIP request (497 bytes) to TCP:159.65.186.176:28259 --->
OPTIONS sip:[email protected]:28259;transport=TCP;rinstance=CEA3A328 SIP/2.0
Via: SIP/2.0/TCP 212.95.115.1:5060;rport;branch=z9hG4bKPj9bcb03ab-cc25-4a75-a127-17c9db33e4e2;alias
From: <sip:[email protected]>;tag=960868f5-27aa-4125-a491-4ad146d85d20
To: <sip:[email protected];rinstance=CEA3A328>
Contact: <sip:[email protected]:5060;transport=TCP>
Call-ID: a250516f-af52-4353-a0ac-feda9b7869c1
CSeq: 14928 OPTIONS
Max-Forwards: 70
User-Agent: FPBX-15.0.17.55(16.20.0)
Content-Length:  0


<--- Received SIP response (485 bytes) from UDP:10.200.20.89:5060 --->
SIP/2.0 200 OK
Via: SIP/2.0/UDP 10.200.20.5:5060;rport=5060;branch=z9hG4bKPj26a83f2c-c67f-44ff-ba97-0f7b247d746b
From: <sip:[email protected]>;tag=281223a3-42bb-4a2c-9f43-dacf10f7dd49
To: <sip:[email protected]>;tag=1539416868
Call-ID: f069a8af-595e-44c3-8a24-199f92391b13
CSeq: 48286 OPTIONS
Supported: replaces, path, timer
User-Agent: Grandstream GXP2170 1.0.11.10
Allow: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE, MESSAGE
Content-Length: 0


<--- Received SIP response (545 bytes) from TCP:159.65.186.176:26505 --->
SIP/2.0 200 OK
Via: SIP/2.0/TCP 212.95.115.1:5060;rport=5060;branch=z9hG4bKPj5e133fe6-9879-4952-8b01-f28c3c06e1fd;alias;received=212.95.115.1
Contact: <sip:[email protected]:26505;transport=tcp>
From: <sip:[email protected]>;tag=d497eb91-d82c-4a43-bf97-8b2dd8c86ba7
Call-ID: 22cead31-8157-43c8-b499-139e72fbf5bc
CSeq: 13929 OPTIONS
To: <sip:[email protected];rinstance=18954785>
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces, path
Accept: application/sdp
User-Agent: Acrobits SIPIS
Content-Length: 0


<--- Received SIP response (545 bytes) from TCP:159.65.186.176:28259 --->
SIP/2.0 200 OK
Via: SIP/2.0/TCP 212.95.115.1:5060;rport=5060;branch=z9hG4bKPj9bcb03ab-cc25-4a75-a127-17c9db33e4e2;alias;received=212.95.115.1
Contact: <sip:[email protected]:28259;transport=tcp>
From: <sip:[email protected]>;tag=960868f5-27aa-4125-a491-4ad146d85d20
Call-ID: a250516f-af52-4353-a0ac-feda9b7869c1
CSeq: 14928 OPTIONS
To: <sip:[email protected];rinstance=CEA3A328>
Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER
Supported: replaces, path
Accept: application/sdp
User-Agent: Acrobits SIPIS
Content-Length: 0



<--- Transmitting SIP response (495 bytes) to UDP:10.200.20.76:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.200.20.76:5060;rport=5060;received=10.200.20.76;branch=z9hG4bK1378322871
Call-ID: [email protected]
From: <sip:[email protected]>;tag=2130359101
To: <sip:[email protected]>;tag=z9hG4bK1378322871
CSeq: 5599320 SUBSCRIBE
WWW-Authenticate: Digest realm="asterisk",nonce="1651774280/c29bcde1126e404bf16022a4e2c8b16f",opaque="35eb79f339088b74",algorithm=md5,qop="auth"
Server: FPBX-15.0.17.55(16.20.0)
Content-Length:  0



<--- Received SIP request (1209 bytes) from UDP:10.200.20.89:5060 --->
INVITE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 10.200.20.89:5060;branch=z9hG4bK385288353;rport
Route: <sip:10.200.20.5:5060;lr>
From: "P.Geschke" <sip:[email protected]>;tag=621145336
To: <sip:[email protected]>
Call-ID: [email protected]
CSeq: 290 INVITE
Contact: "P.Geschke" <sip:[email protected]:5060>
X-Grandstream-PBX: true
Max-Forwards: 70
User-Agent: Grandstream GXP2170 1.0.11.10
Privacy: none
P-Preferred-Identity: "P.Geschke" <sip:[email protected]>
P-Emergency-Info: IEEE-EUI-48;eui-48-addr=C0-74-AD-38-AA-02
Supported: replaces, path, timer
Allow: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE, MESSAGE
Content-Type: application/sdp
Accept: application/sdp, application/dtmf-relay
Content-Length:   432

v=0
o=995 8000 8000 IN IP4 10.200.20.89
s=SIP Call
c=IN IP4 10.200.20.89
t=0 0
m=audio 5072 RTP/AVP 0 8 4 18 9 97 2 123 101
a=sendrecv
a=rtpmap:0 PCMU/8000
a=ptime:20
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:9 G722/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:2 G726-32/8000
a=rtpmap:123 opus/48000/2
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

<--- Transmitting SIP response (484 bytes) to UDP:10.200.20.89:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 10.200.20.89:5060;rport=5060;received=10.200.20.89;branch=z9hG4bK385288353
Call-ID: [email protected]
From: "P.Geschke" <sip:[email protected]>;tag=621145336
To: <sip:[email protected]>;tag=z9hG4bK385288353
CSeq: 290 INVITE
WWW-Authenticate: Digest realm="asterisk",nonce="1651774280/54fc1e09fcf12ac2899b6be9e5f04e71",opaque="5e1a6faa38396e85",algorithm=md5,qop="auth"
Server: FPBX-15.0.17.55(16.20.0)
Content-Length:  0


<--- Received SIP request (314 bytes) from UDP:10.200.20.89:5060 --->
ACK sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 10.200.20.89:5060;branch=z9hG4bK385288353;rport
Route: <sip:10.200.20.5:5060;lr>
From: "P.Geschke" <sip:[email protected]>;tag=621145336
To: <sip:[email protected]>;tag=z9hG4bK385288353
Call-ID: [email protected]
CSeq: 290 ACK
Content-Length: 0


<--- Received SIP request (1475 bytes) from UDP:10.200.20.89:5060 --->
INVITE sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 10.200.20.89:5060;branch=z9hG4bK1657104612;rport
Route: <sip:10.200.20.5:5060;lr>
From: "P.Geschke" <sip:[email protected]>;tag=621145336
To: <sip:[email protected]>
Call-ID: [email protected]
CSeq: 291 INVITE
Contact: "P.Geschke" <sip:[email protected]:5060>
Authorization: Digest username="995", realm="asterisk", nonce="1651774280/54fc1e09fcf12ac2899b6be9e5f04e71", uri="sip:[email protected]", response="786b598fd82a6691c0a5908ba51c6d68", algorithm=md5, cnonce="11386246", opaque="5e1a6faa38396e85", qop=auth, nc=00000001
X-Grandstream-PBX: true
Max-Forwards: 70
User-Agent: Grandstream GXP2170 1.0.11.10
Privacy: none
P-Preferred-Identity: "P.Geschke" <sip:[email protected]>
P-Emergency-Info: IEEE-EUI-48;eui-48-addr=C0-74-AD-38-AA-02
Supported: replaces, path, timer
Allow: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE, MESSAGE
Content-Type: application/sdp
Accept: application/sdp, application/dtmf-relay
Content-Length:   432

v=0
o=995 8000 8000 IN IP4 10.200.20.89
s=SIP Call
c=IN IP4 10.200.20.89
t=0 0
m=audio 5072 RTP/AVP 0 8 4 18 9 97 2 123 101
a=sendrecv
a=rtpmap:0 PCMU/8000
a=ptime:20
a=rtpmap:8 PCMA/8000
a=rtpmap:4 G723/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:9 G722/8000
a=rtpmap:97 iLBC/8000
a=fmtp:97 mode=30
a=rtpmap:2 G726-32/8000
a=rtpmap:123 opus/48000/2
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15

<--- Transmitting SIP response (312 bytes) to UDP:10.200.20.89:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 10.200.20.89:5060;rport=5060;received=10.200.20.89;branch=z9hG4bK1657104612
Call-ID: [email protected]
From: "P.Geschke" <sip:[email protected]>;tag=621145336
To: <sip:[email protected]>
CSeq: 291 INVITE
Server: FPBX-15.0.17.55(16.20.0)
Content-Length:  0


  == Using SIP RTP Audio TOS bits 184
  == Using SIP RTP Audio TOS bits 184 in TCLASS field.
  == Using SIP RTP Audio CoS mark 5
    -- Executing [401@from-internal:1] GotoIf("PJSIP/995-000206a9", "1?ext-local,401,1:followme-check,401,1") in new stack
    -- Goto (ext-local,401,1)
    -- Executing [401@ext-local:1] Set("PJSIP/995-000206a9", "__RINGTIMER=15") in new stack
    -- Executing [401@ext-local:2] ExecIf("PJSIP/995-000206a9", "0?Set(__CWIGNORE=)") in new stack
    -- Executing [401@ext-local:3] Macro("PJSIP/995-000206a9", "exten-vm,novm,401,0,0,0") in new stack
    -- Executing [s@macro-exten-vm:1] Macro("PJSIP/995-000206a9", "user-callerid,") in new stack
    -- Executing [s@macro-user-callerid:1] Set("PJSIP/995-000206a9", "TOUCH_MONITOR=1651774280.202403") in new stack
    -- Executing [s@macro-user-callerid:2] Set("PJSIP/995-000206a9", "CHANCONTEXT=") in new stack
    -- Executing [s@macro-user-callerid:3] Set("PJSIP/995-000206a9", "CHANCONTEXT=") in new stack
    -- Executing [s@macro-user-callerid:4] Set("PJSIP/995-000206a9", "CHANEXTENCONTEXT=995-000206a9") in new stack
    -- Executing [s@macro-user-callerid:5] Set("PJSIP/995-000206a9", "CHANEXTEN=995-000206a9") in new stack
    -- Executing [s@macro-user-callerid:6] Set("PJSIP/995-000206a9", "CALLERID(number)=995") in new stack
    -- Executing [s@macro-user-callerid:7] Set("PJSIP/995-000206a9", "AMPUSER=995") in new stack
    -- Executing [s@macro-user-callerid:8] Set("PJSIP/995-000206a9", "HOTDESCKCHAN=995-000206a9") in new stack
    -- Executing [s@macro-user-callerid:9] Set("PJSIP/995-000206a9", "HOTDESKEXTEN=995") in new stack
    -- Executing [s@macro-user-callerid:10] Set("PJSIP/995-000206a9", "HOTDESKCALL=0") in new stack
    -- Executing [s@macro-user-callerid:11] ExecIf("PJSIP/995-000206a9", "0?Set(HOTDESKCALL=1)") in new stack
    -- Executing [s@macro-user-callerid:12] ExecIf("PJSIP/995-000206a9", "0?Set(CALLERID(name)=)") in new stack
    -- Executing [s@macro-user-callerid:13] GotoIf("PJSIP/995-000206a9", "0?report") in new stack
    -- Executing [s@macro-user-callerid:14] ExecIf("PJSIP/995-000206a9", "1?Set(REALCALLERIDNUM=995)") in new stack
    -- Executing [s@macro-user-callerid:15] Set("PJSIP/995-000206a9", "AMPUSER=995") in new stack
    -- Executing [s@macro-user-callerid:16] GotoIf("PJSIP/995-000206a9", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:17] Set("PJSIP/995-000206a9", "AMPUSERCIDNAME=Patrick Geschke") in new stack
    -- Executing [s@macro-user-callerid:18] ExecIf("PJSIP/995-000206a9", "0?Set(__CIDMASQUERADING=TRUE)") in new stack
    -- Executing [s@macro-user-callerid:19] GotoIf("PJSIP/995-000206a9", "0?report") in new stack
    -- Executing [s@macro-user-callerid:20] Set("PJSIP/995-000206a9", "AMPUSERCID=995") in new stack
    -- Executing [s@macro-user-callerid:21] Set("PJSIP/995-000206a9", "__DIAL_OPTIONS=HhTtr") in new stack
    -- Executing [s@macro-user-callerid:22] Set("PJSIP/995-000206a9", "CALLERID(all)="Patrick Geschke" <995>") in new stack
    -- Executing [s@macro-user-callerid:23] ExecIf("PJSIP/995-000206a9", "0?Set(CUSDIAL=401)") in new stack
    -- Executing [s@macro-user-callerid:24] ExecIf("PJSIP/995-000206a9", "0?Set(CALLERID(all)="Patrick Geschke" <995>)") in new stack
    -- Executing [s@macro-user-callerid:25] GotoIf("PJSIP/995-000206a9", "0?limit") in new stack
    -- Executing [s@macro-user-callerid:26] ExecIf("PJSIP/995-000206a9", "0?Set(GROUP(concurrency_limit)=995)") in new stack
    -- Executing [s@macro-user-callerid:27] ExecIf("PJSIP/995-000206a9", "1?Set(CHANNEL(language)=de_DE)") in new stack
    -- Executing [s@macro-user-callerid:28] NoOp("PJSIP/995-000206a9", "Macro Depth is 2") in new stack
    -- Executing [s@macro-user-callerid:29] GotoIf("PJSIP/995-000206a9", "1?report2:macroerror") in new stack
    -- Goto (macro-user-callerid,s,30)
    -- Executing [s@macro-user-callerid:30] GotoIf("PJSIP/995-000206a9", "0?continue") in new stack
    -- Executing [s@macro-user-callerid:31] ExecIf("PJSIP/995-000206a9", "1?Set(__CALLEE_ACCOUNCODE=)") in new stack
    -- Executing [s@macro-user-callerid:32] Set("PJSIP/995-000206a9", "__TTL=64") in new stack
    -- Executing [s@macro-user-callerid:33] GotoIf("PJSIP/995-000206a9", "1?continue") in new stack
    -- Goto (macro-user-callerid,s,49)
    -- Executing [s@macro-user-callerid:49] Set("PJSIP/995-000206a9", "CALLERID(number)=995") in new stack
    -- Executing [s@macro-user-callerid:50] Set("PJSIP/995-000206a9", "CALLERID(name)=Patrick Geschke") in new stack
    -- Executing [s@macro-user-callerid:51] GotoIf("PJSIP/995-000206a9", "0?cnum") in new stack
    -- Executing [s@macro-user-callerid:52] Set("PJSIP/995-000206a9", "CDR(cnam)=Patrick Geschke") in new stack
    -- Executing [s@macro-user-callerid:53] Set("PJSIP/995-000206a9", "CDR(cnum)=995") in new stack
    -- Executing [s@macro-user-callerid:54] Set("PJSIP/995-000206a9", "CHANNEL(language)=de_DE") in new stack
    -- Executing [s@macro-exten-vm:2] Set("PJSIP/995-000206a9", "RingGroupMethod=none") in new stack
    -- Executing [s@macro-exten-vm:3] Set("PJSIP/995-000206a9", "__EXTTOCALL=401") in new stack
    -- Executing [s@macro-exten-vm:4] Set("PJSIP/995-000206a9", "__PICKUPMARK=401") in new stack
    -- Executing [s@macro-exten-vm:5] Set("PJSIP/995-000206a9", "RT=") in new stack
[2022-05-05 20:11:20] ERROR[13124][C-00002a7e]: pbx_functions.c:608 ast_func_read: Function SIP_HEADER not registered
    -- Executing [s@macro-exten-vm:6] ExecIf("PJSIP/995-000206a9", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
[2022-05-05 20:11:20] ERROR[13124][C-00002a7e]: pbx_functions.c:651 ast_func_read2: Function SIP_HEADER not registered
[2022-05-05 20:11:20] ERROR[13124][C-00002a7e]: pbx_functions.c:608 ast_func_read: Function SIP_HEADER not registered
    -- Executing [s@macro-exten-vm:7] ExecIf("PJSIP/995-000206a9", "0?MacroExit()") in new stack
[2022-05-05 20:11:20] ERROR[13124][C-00002a7e]: pbx_functions.c:651 ast_func_read2: Function SIP_HEADER not registered
    -- Executing [s@macro-exten-vm:8] ExecIf("PJSIP/995-000206a9", "0?Macro(vm,novm,DIRECTDIAL,)") in new stack
    -- Executing [s@macro-exten-vm:9] ExecIf("PJSIP/995-000206a9", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:10] Gosub("PJSIP/995-000206a9", "sub-record-check,s,1(exten,401,dontcare)") in new stack
    -- Executing [s@sub-record-check:1] GotoIf("PJSIP/995-000206a9", "0?initialized") in new stack
    -- Executing [s@sub-record-check:2] Set("PJSIP/995-000206a9", "__REC_STATUS=INITIALIZED") in new stack
    -- Executing [s@sub-record-check:3] Set("PJSIP/995-000206a9", "NOW=1651774280") in new stack
    -- Executing [s@sub-record-check:4] Set("PJSIP/995-000206a9", "__DAY=05") in new stack
    -- Executing [s@sub-record-check:5] Set("PJSIP/995-000206a9", "__MONTH=05") in new stack
    -- Executing [s@sub-record-check:6] Set("PJSIP/995-000206a9", "__YEAR=2022") in new stack
    -- Executing [s@sub-record-check:7] Set("PJSIP/995-000206a9", "__TIMESTR=20220505-201120") in new stack
    -- Executing [s@sub-record-check:8] Set("PJSIP/995-000206a9", "__FROMEXTEN=995") in new stack
    -- Executing [s@sub-record-check:9] Set("PJSIP/995-000206a9", "__MON_FMT=wav") in new stack
    -- Executing [s@sub-record-check:10] NoOp("PJSIP/995-000206a9", "Recordings initialized") in new stack
    -- Executing [s@sub-record-check:11] ExecIf("PJSIP/995-000206a9", "0?Set(ARG3=dontcare)") in new stack
    -- Executing [s@sub-record-check:12] Set("PJSIP/995-000206a9", "REC_POLICY_MODE_SAVE=") in new stack
    -- Executing [s@sub-record-check:13] ExecIf("PJSIP/995-000206a9", "0?Set(REC_STATUS=NO)") in new stack
    -- Executing [s@sub-record-check:14] GotoIf("PJSIP/995-000206a9", "5?checkaction") in new stack
    -- Goto (sub-record-check,s,17)
    -- Executing [s@sub-record-check:17] GotoIf("PJSIP/995-000206a9", "1?sub-record-check,exten,1") in new stack
    -- Goto (sub-record-check,exten,1)
    -- Executing [exten@sub-record-check:1] NoOp("PJSIP/995-000206a9", "Exten Recording Check between 995 and 401") in new stack
    -- Executing [exten@sub-record-check:2] Set("PJSIP/995-000206a9", "CALLTYPE=internal") in new stack
    -- Executing [exten@sub-record-check:3] ExecIf("PJSIP/995-000206a9", "0?Set(CALLTYPE=)") in new stack
    -- Executing [exten@sub-record-check:4] Set("PJSIP/995-000206a9", "CALLEE=dontcare") in new stack
    -- Executing [exten@sub-record-check:5] ExecIf("PJSIP/995-000206a9", "0?Set(CALLEE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:6] GotoIf("PJSIP/995-000206a9", "0?callee") in new stack
    -- Executing [exten@sub-record-check:7] GotoIf("PJSIP/995-000206a9", "1?caller") in new stack
    -- Goto (sub-record-check,exten,13)
    -- Executing [exten@sub-record-check:13] Set("PJSIP/995-000206a9", "RECMODE=dontcare") in new stack
    -- Executing [exten@sub-record-check:14] Set("PJSIP/995-000206a9", "CALLERRECMODE=dontcare") in new stack
    -- Executing [exten@sub-record-check:15] Set("PJSIP/995-000206a9", "CALEERECMODE=dontcare") in new stack
    -- Executing [exten@sub-record-check:16] GotoIf("PJSIP/995-000206a9", "0?processnormal") in new stack
    -- Executing [exten@sub-record-check:17] ExecIf("PJSIP/995-000206a9", "0?Set(RECMODE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:18] ExecIf("PJSIP/995-000206a9", "0?Set(RECMODE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:19] ExecIf("PJSIP/995-000206a9", "0?Set(RECMODE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:20] ExecIf("PJSIP/995-000206a9", "0?Set(RECMODE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:21] ExecIf("PJSIP/995-000206a9", "0?Set(RECMODE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:22] ExecIf("PJSIP/995-000206a9", "1?Set(RECMODE=dontcare)") in new stack
    -- Executing [exten@sub-record-check:23] Gosub("PJSIP/995-000206a9", "recordcheck,1(dontcare,internal,401)") in new stack
    -- Executing [recordcheck@sub-record-check:1] NoOp("PJSIP/995-000206a9", "Starting recording check against dontcare") in new stack
    -- Executing [recordcheck@sub-record-check:2] Goto("PJSIP/995-000206a9", "dontcare") in new stack
    -- Goto (sub-record-check,recordcheck,3)
    -- Executing [recordcheck@sub-record-check:3] Return("PJSIP/995-000206a9", "") in new stack
    -- Executing [exten@sub-record-check:24] Return("PJSIP/995-000206a9", "") in new stack
    -- Executing [s@macro-exten-vm:11] GotoIf("PJSIP/995-000206a9", "1?macrodial") in new stack
    -- Goto (macro-exten-vm,s,17)
    -- Executing [s@macro-exten-vm:17] GosubIf("PJSIP/995-000206a9", "0?clrheader,1()") in new stack
    -- Executing [s@macro-exten-vm:18] Macro("PJSIP/995-000206a9", "dial-one,,HhTtr,401") in new stack
    -- Executing [s@macro-dial-one:1] Set("PJSIP/995-000206a9", "DEXTEN=401") in new stack
    -- Executing [s@macro-dial-one:2] ExecIf("PJSIP/995-000206a9", "0?Set(__EXTTOCALL=401)") in new stack
    -- Executing [s@macro-dial-one:3] Set("PJSIP/995-000206a9", "DIALSTATUS_CW=") in new stack
    -- Executing [s@macro-dial-one:4] GosubIf("PJSIP/995-000206a9", "0?screen,1()") in new stack
    -- Executing [s@macro-dial-one:5] GosubIf("PJSIP/995-000206a9", "0?cf,1()") in new stack
    -- Executing [s@macro-dial-one:6] GotoIf("PJSIP/995-000206a9", "1?skip1") in new stack
    -- Goto (macro-dial-one,s,9)
    -- Executing [s@macro-dial-one:9] GotoIf("PJSIP/995-000206a9", "0?nodial") in new stack
    -- Executing [s@macro-dial-one:10] GotoIf("PJSIP/995-000206a9", "0?continue") in new stack
    -- Executing [s@macro-dial-one:11] Set("PJSIP/995-000206a9", "EXTHASCW=ENABLED") in new stack
    -- Executing [s@macro-dial-one:12] GotoIf("PJSIP/995-000206a9", "0?next1:cwinusebusy") in new stack
    -- Goto (macro-dial-one,s,24)
    -- Executing [s@macro-dial-one:24] GotoIf("PJSIP/995-000206a9", "0?next3:continue") in new stack
    -- Goto (macro-dial-one,s,26)
    -- Executing [s@macro-dial-one:26] GotoIf("PJSIP/995-000206a9", "0?nodial") in new stack
    -- Executing [s@macro-dial-one:27] GosubIf("PJSIP/995-000206a9", "1?dstring,1():dlocal,1()") in new stack
    -- Executing [dstring@macro-dial-one:1] Set("PJSIP/995-000206a9", "DSTRING=") in new stack
    -- Executing [dstring@macro-dial-one:2] Set("PJSIP/995-000206a9", "DEVICES=401") in new stack
    -- Executing [dstring@macro-dial-one:3] ExecIf("PJSIP/995-000206a9", "0?Return()") in new stack
    -- Executing [dstring@macro-dial-one:4] ExecIf("PJSIP/995-000206a9", "0?Set(DEVICES=01)") in new stack
    -- Executing [dstring@macro-dial-one:5] Set("PJSIP/995-000206a9", "LOOPCNT=1") in new stack
    -- Executing [dstring@macro-dial-one:6] Set("PJSIP/995-000206a9", "ITER=1") in new stack
    -- Executing [dstring@macro-dial-one:7] Set("PJSIP/995-000206a9", "THISDIAL=PJSIP/401") in new stack
    -- Executing [dstring@macro-dial-one:8] GotoIf("PJSIP/995-000206a9", "0?docheck") in new stack
    -- Executing [dstring@macro-dial-one:9] NoOp("PJSIP/995-000206a9", "Debug: Found PJSIP Destination PJSIP/401") in new stack
    -- Executing [dstring@macro-dial-one:10] GotoIf("PJSIP/995-000206a9", "0?doset") in new stack
    -- Executing [dstring@macro-dial-one:11] NoOp("PJSIP/995-000206a9", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
    -- Executing [dstring@macro-dial-one:12] Set("PJSIP/995-000206a9", "THISDIAL=") in new stack
    -- Executing [dstring@macro-dial-one:13] ExecIf("PJSIP/995-000206a9", "1?Set(DIALSTATUS=CHANUNAVAIL)") in new stack
    -- Executing [dstring@macro-dial-one:14] GotoIf("PJSIP/995-000206a9", "1?skipset") in new stack
    -- Goto (macro-dial-one,dstring,16)
    -- Executing [dstring@macro-dial-one:16] Set("PJSIP/995-000206a9", "ITER=2") in new stack
    -- Executing [dstring@macro-dial-one:17] GotoIf("PJSIP/995-000206a9", "0?begin") in new stack
    -- Executing [dstring@macro-dial-one:18] ExecIf("PJSIP/995-000206a9", "1?Return()") in new stack
    -- Executing [s@macro-dial-one:28] GotoIf("PJSIP/995-000206a9", "1?nodial") in new stack
    -- Goto (macro-dial-one,s,60)
    -- Executing [s@macro-dial-one:60] NoOp("PJSIP/995-000206a9", "") in new stack
    -- Executing [s@macro-dial-one:61] ExecIf("PJSIP/995-000206a9", "0?Set(DIALSTATUS=NOANSWER)") in new stack
    -- Executing [s@macro-dial-one:62] NoOp("PJSIP/995-000206a9", "Returned from dial-one with nothing to call and DIALSTATUS: CHANUNAVAIL") in new stack
    -- Executing [s@macro-dial-one:63] MacroExit("PJSIP/995-000206a9", "") in new stack
    -- Executing [s@macro-exten-vm:19] Set("PJSIP/995-000206a9", "SV_DIALSTATUS=CHANUNAVAIL") in new stack
    -- Executing [s@macro-exten-vm:20] GosubIf("PJSIP/995-000206a9", "0?docfu,1()") in new stack
    -- Executing [s@macro-exten-vm:21] GosubIf("PJSIP/995-000206a9", "0?docfb,1()") in new stack
    -- Executing [s@macro-exten-vm:22] Set("PJSIP/995-000206a9", "DIALSTATUS=CHANUNAVAIL") in new stack
    -- Executing [s@macro-exten-vm:23] ExecIf("PJSIP/995-000206a9", "0?MacroExit()") in new stack
    -- Executing [s@macro-exten-vm:24] GotoIf("PJSIP/995-000206a9", "1?s-CHANUNAVAIL,1") in new stack
    -- Goto (macro-exten-vm,s-CHANUNAVAIL,1)
    -- Executing [s-CHANUNAVAIL@macro-exten-vm:1] GotoIf("PJSIP/995-000206a9", "0?exit,1") in new stack
    -- Executing [s-CHANUNAVAIL@macro-exten-vm:2] PlayTones("PJSIP/995-000206a9", "congestion") in new stack
    -- Executing [s-CHANUNAVAIL@macro-exten-vm:3] Congestion("PJSIP/995-000206a9", "10") in new stack
<--- Transmitting SIP response (390 bytes) to UDP:10.200.20.89:5060 --->
SIP/2.0 503 Service Unavailable
Via: SIP/2.0/UDP 10.200.20.89:5060;rport=5060;received=10.200.20.89;branch=z9hG4bK1657104612
Call-ID: [email protected]
From: "P.Geschke" <sip:[email protected]>;tag=621145336
To: <sip:[email protected]>;tag=3c5dd90b-c45c-4a6f-9856-55024e4dbdf5
CSeq: 291 INVITE
Server: FPBX-15.0.17.55(16.20.0)
Reason: Q.850;cause=34
Content-Length:  0



<--- Received SIP request (335 bytes) from UDP:10.200.20.89:5060 --->
ACK sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 10.200.20.89:5060;branch=z9hG4bK1657104612;rport
Route: <sip:10.200.20.5:5060;lr>
From: "P.Geschke" <sip:[email protected]>;tag=621145336
To: <sip:[email protected]>;tag=3c5dd90b-c45c-4a6f-9856-55024e4dbdf5
Call-ID: [email protected]
CSeq: 291 ACK
Content-Length: 0


  == Spawn extension (macro-exten-vm, s-CHANUNAVAIL, 3) exited non-zero on 'PJSIP/995-000206a9' in macro 'exten-vm'
  == Spawn extension (ext-local, 401, 3) exited non-zero on 'PJSIP/995-000206a9'
    -- Executing [h@ext-local:1] Macro("PJSIP/995-000206a9", "hangupcall,") in new stack
    -- Executing [s@macro-hangupcall:1] GotoIf("PJSIP/995-000206a9", "1?theend") in new stack
    -- Goto (macro-hangupcall,s,3)
    -- Executing [s@macro-hangupcall:3] ExecIf("PJSIP/995-000206a9", "0?Set(CDR(recordingfile)=)") in new stack
    -- Executing [s@macro-hangupcall:4] Hangup("PJSIP/995-000206a9", "") in new stack
  == Spawn extension (macro-hangupcall, s, 4) exited non-zero on 'PJSIP/995-000206a9' in macro 'hangupcall'
  == Spawn extension (ext-local, h, 1) exited non-zero on 'PJSIP/995-000206a9'
<--- Received SIP response (504 bytes) from UDP:10.200.20.86:5060 --->
SIP/2.0 481 Subscription Does Not Exist
Via: SIP/2.0/UDP 10.200.20.5:5060;rport=5060;branch=z9hG4bKPj9c9409d7-8ec1-4b78-9fa0-5e5ea1c4c7aa
From: <sip:[email protected]>;tag=fd4f1035-e2f8-4d51-9483-9f3f39c64a35
To: <sip:[email protected]>;tag=1974275628
Call-ID: [email protected]
CSeq: 30105 NOTIFY
Supported: replaces, path, timer
User-Agent: Grandstream GXP2170 1.0.11.10
Allow: INVITE, ACK, OPTIONS, CANCEL, BYE, SUBSCRIBE, NOTIFY, INFO, REFER, UPDATE, MESSAGE
Content-Length: 0

pge · May 5, 2022, 6:20pm

Doesnt look like it.

pgeschke@hyperion:~$ telnet 10.200.20.90 2111
Trying 10.200.20.90...
telnet: Unable to connect to remote host: Connection refused

david55 · May 5, 2022, 6:22pm

pge:

    -- Executing [dstring@macro-dial-one:9] NoOp("PJSIP/995-000206a9", "Debug: Found PJSIP Destination PJSIP/401") in new stack
    -- Executing [dstring@macro-dial-one:10] GotoIf("PJSIP/995-000206a9", "0?doset") in new stack
    -- Executing [dstring@macro-dial-one:11] NoOp("PJSIP/995-000206a9", "Debug: Updating PJSIP Destination with PJSIP_DIAL_CONTACTS") in new stack
    -- Executing [dstring@macro-dial-one:12] Set("PJSIP/995-000206a9", "THISDIAL=") in new stack
    -- Executing [dstring@macro-dial-one:13] ExecIf("PJSIP/995-000206a9", "1?Set(DIALSTATUS=CHANUNAVAIL)") in new stack

Does look as though it doesn’t think any contacts are registered for the endpoint.

pge · May 5, 2022, 6:24pm

How would one solve that?
I entered the registration into the phone.
Does it need a seperate contact declaration?

david55 · May 5, 2022, 7:21pm

I wouldn’t expect anything explicit, although there might be an option to set the local port number, or to set it at random.

pge · May 5, 2022, 7:26pm

Thats the best i could find - port related…

david55 · May 5, 2022, 7:43pm

Is there anything, e.g. a router, other than etthernet switches between the phone and Asterisk?

Can you answer the question about whether the TCP connection, from the register, is still up, or whether you can connect to the port number from the register.

Could you look through the logs for messages about losing the registration.

Could you try and get it working with UDP, first (why do you need TCP?).

pge · May 5, 2022, 8:14pm

It could be that the problem is solved.
I switched registration to SIP/UDP and i have a ringtone on calls. I have left the office, therefore i cant verify but will do tomorrow.
Thanks in advance!

Edit: IP-Cam in the office solved that. It works with UDP reg.

system · May 12, 2022, 8:14pm

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