We aren’t using the network that much - and no video streaming. In fact, there are only four users in today - and they’re doing very little on the internet. Today is a slow day - we have been getting or making 2 calls an hour. We have a 500/50 connection.
Here are part of my logs from just in the last hour, which show one of our extensions going UNREACHABLE, then REACHABLE 10 seconds later. The port doesn’t change, so it doesn’t seem to be a NAT issue. And this time - it only did four retransmissions before going UNREACHABLE.
(We use a custom SIP port, so I’ve substituted xx60 for the custom SIP port in the logs.)
Reliably Transmitting (NAT) to STATIC-ISP-IP:4624:
OPTIONS sip:[email protected]:XX60 SIP/2.0
Via: SIP/2.0/UDP PHONE-SERVER-IP:XX60;branch=z9hG4bK4dd229a2;rport
Max-Forwards: 70
From: “Unknown” sip:Unknown@PHONE-SERVER-IP:XX60;tag=as4035a96e
To: sip:[email protected]:XX60
Contact: sip:Unknown@PHONE-SERVER-IP:XX60
Call-ID: 1824c77c2d8458203a4266c13900d478@PHONE-SERVER-IP:XX60
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.21(16.20.0)
Date: Thu, 24 Feb 2022 18:26:44 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0
Retransmitting #1 (NAT) to STATIC-ISP-IP:4624:
OPTIONS sip:[email protected]:XX60 SIP/2.0
Via: SIP/2.0/UDP PHONE-SERVER-IP:XX60;branch=z9hG4bK4dd229a2;rport
Max-Forwards: 70
From: “Unknown” sip:Unknown@PHONE-SERVER-IP:XX60;tag=as4035a96e
To: sip:[email protected]:XX60
Contact: sip:Unknown@PHONE-SERVER-IP:XX60
Call-ID: 1824c77c2d8458203a4266c13900d478@PHONE-SERVER-IP:XX60
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.21(16.20.0)
Date: Thu, 24 Feb 2022 18:26:44 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0
Retransmitting #2 (NAT) to STATIC-ISP-IP:4624:
OPTIONS sip:[email protected]:XX60 SIP/2.0
Via: SIP/2.0/UDP PHONE-SERVER-IP:XX60;branch=z9hG4bK4dd229a2;rport
Max-Forwards: 70
From: “Unknown” sip:Unknown@PHONE-SERVER-IP:XX60;tag=as4035a96e
To: sip:[email protected]:XX60
Contact: sip:Unknown@PHONE-SERVER-IP:XX60
Call-ID: 1824c77c2d8458203a4266c13900d478@PHONE-SERVER-IP:XX60
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.21(16.20.0)
Date: Thu, 24 Feb 2022 18:26:44 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0
Retransmitting #3 (NAT) to STATIC-ISP-IP:4624:
OPTIONS sip:[email protected]:XX60 SIP/2.0
Via: SIP/2.0/UDP PHONE-SERVER-IP:XX60;branch=z9hG4bK4dd229a2;rport
Max-Forwards: 70
From: “Unknown” sip:Unknown@PHONE-SERVER-IP:XX60;tag=as4035a96e
To: sip:[email protected]:XX60
Contact: sip:Unknown@PHONE-SERVER-IP:XX60
Call-ID: 1824c77c2d8458203a4266c13900d478@PHONE-SERVER-IP:XX60
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.21(16.20.0)
Date: Thu, 24 Feb 2022 18:26:44 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0
Retransmitting #4 (NAT) to STATIC-ISP-IP:4624:
OPTIONS sip:[email protected]:XX60 SIP/2.0
Via: SIP/2.0/UDP PHONE-SERVER-IP:XX60;branch=z9hG4bK4dd229a2;rport
Max-Forwards: 70
From: “Unknown” sip:Unknown@PHONE-SERVER-IP:XX60;tag=as4035a96e
To: sip:[email protected]:XX60
Contact: sip:Unknown@PHONE-SERVER-IP:XX60
Call-ID: 1824c77c2d8458203a4266c13900d478@PHONE-SERVER-IP:XX60
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.21(16.20.0)
Date: Thu, 24 Feb 2022 18:26:44 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0
[2022-02-24 12:26:48] NOTICE[3550]: chan_sip.c:30535 sip_poke_noanswer: Peer ‘103’ is now UNREACHABLE! Last qualify: 383
With 10 seconds, I find this in my logs:
Reliably Transmitting (NAT) to STATIC-ISP-IP:4624:
OPTIONS sip:[email protected]:XX60 SIP/2.0
Via: SIP/2.0/UDP PHONE-SERVER-IP:XX60;branch=z9hG4bK4f537d36;rport
Max-Forwards: 70
From: “Unknown” sip:Unknown@PHONE-SERVER-IP:XX60;tag=as1802f4c4
To: sip:[email protected]:XX60
Contact: sip:Unknown@PHONE-SERVER-IP:XX60
Call-ID: 2de8e1aa0996720f24a578f8055137bc@PHONE-SERVER-IP:XX60
CSeq: 102 OPTIONS
User-Agent: FPBX-15.0.21(16.20.0)
Date: Thu, 24 Feb 2022 18:26:58 GMT
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE
Supported: replaces, timer
Content-Length: 0
<— SIP read from UDP:STATIC-ISP-IP:4624 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP PHONE-SERVER-IP:XX60;branch=z9hG4bK4f537d36;rport=XX60;received=PHONE-SERVER-IP
Call-ID: 2de8e1aa0996720f24a578f8055137bc@PHONE-SERVER-IP:XX60
From: “Unknown” sip:Unknown@PHONE-SERVER-IP:XX60;tag=as1802f4c4
To: sip:[email protected]:XX60;tag=3336307575
CSeq: 102 OPTIONS
Allow: INVITE,ACK,CANCEL,BYE,INFO,UPDATE,OPTIONS,NOTIFY,REFER
Contact: sip:192.168.1.103:XX60
Server: Panasonic_KX-UT133/01.302 (0080f0c56e33)
Content-Length: 0
<------------->
— (10 headers 0 lines) —
[2022-02-24 12:26:58] NOTICE[3550]: chan_sip.c:24999 handle_response_peerpoke: Peer ‘103’ is now Reachable. (184ms / 2000ms)