Server randomly stop accepting registrations until freeswitch restart.

Status
Not open for further replies.

Nedo

Member
Jun 22, 2020
59
3
8
40
I have six fusionpbx instances that have been running for months, one of them started giving me this problem:
I no longer see any extensions connected to the server.
All domains contained in this server no longer have extension registrations.

I tried saving a log from fs_cli:
nta.c:2948 agent_recv_request() nta: received SUBSCRIBE sip:410@futura.con9.cloud SIP/2.0 (CSeq 1) (load: 3 rps)
nta.c:3245 agent_check_request_via() nta: Via check: received=5.157.112.225
nta.c:3082 agent_recv_request() nta: SUBSCRIBE (1) going to existing SUBSCRIBE transaction
tport.c:2762 tport_wakeup_pri() tport_wakeup_pri(0x7f0c9c00f1c0): events IN
tport.c:2893 tport_recv_event() tport_recv_event(0x7f0c9c00f1c0)
tport.c:3230 tport_recv_iovec() tport_recv_iovec(0x7f0c9c00f1c0) msg 0x7f0c6b6f6a40 from (udp/5.249.155.187:5060) has 561 bytes, veclen = 1
tport.c:3048 tport_deliver() tport_deliver(0x7f0c9c00f1c0): msg 0x7f0c6b6f6a40 (561 bytes) from udp/88.149.254.106:5060/sip next=(nil)
nta.c:2948 agent_recv_request() nta: received REGISTER sip:italwood.con9.cloud:5060 SIP/2.0 (CSeq 1) (load: 3 rps)
nta.c:3245 agent_check_request_via() nta: Via check: received=88.149.254.106
nta.c:3082 agent_recv_request() nta: REGISTER (1) going to existing REGISTER transaction
tport.c:2762 tport_wakeup_pri() tport_wakeup_pri(0x7f0c9c00f1c0): events IN
tport.c:2893 tport_recv_event() tport_recv_event(0x7f0c9c00f1c0)
tport.c:3230 tport_recv_iovec() tport_recv_iovec(0x7f0c9c00f1c0) msg 0x7f0c6b6f6a40 from (udp/5.249.155.187:5060) has 561 bytes, veclen = 1
tport.c:3048 tport_deliver() tport_deliver(0x7f0c9c00f1c0): msg 0x7f0c6b6f6a40 (561 bytes) from udp/88.149.254.106:5060/sip next=(nil)
nta.c:2948 agent_recv_request() nta: received REGISTER sip:italwood.con9.cloud:5060 SIP/2.0 (CSeq 1) (load: 3 rps)
nta.c:3245 agent_check_request_via() nta: Via check: received=88.149.254.106
nta.c:3082 agent_recv_request() nta: REGISTER (1) going to existing REGISTER transaction
tport.c:2762 tport_wakeup_pri() tport_wakeup_pri(0x7f0c9c00f1c0): events IN
tport.c:2893 tport_recv_event() tport_recv_event(0x7f0c9c00f1c0)
tport.c:3230 tport_recv_iovec() tport_recv_iovec(0x7f0c9c00f1c0) msg 0x7f0c6b6f7690 from (udp/5.249.155.187:5060) has 561 bytes, veclen = 1
tport.c:3048 tport_deliver() tport_deliver(0x7f0c9c00f1c0): msg 0x7f0c6b6f7690 (561 bytes) from udp/88.149.254.106:5060/sip next=(nil)
nta.c:2948 agent_recv_request() nta: received REGISTER sip:italwood.con9.cloud:5060 SIP/2.0 (CSeq 1) (load: 3 rps)
nta.c:3245 agent_check_request_via() nta: Via check: received=88.149.254.106
nta.c:3082 agent_recv_request() nta: REGISTER (1) going to existing REGISTER transaction
tport.c:2762 tport_wakeup_pri() tport_wakeup_pri(0x7f0c9c00f1c0): events IN
tport.c:2893 tport_recv_event() tport_recv_event(0x7f0c9c00f1c0)
tport.c:3230 tport_recv_iovec() tport_recv_iovec(0x7f0c9c00f1c0) msg 0x7f0c6b6f7690 from (udp/5.249.155.187:5060) has 567 bytes, veclen = 1
tport.c:3048 tport_deliver() tport_deliver(0x7f0c9c00f1c0): msg 0x7f0c6b6f7690 (567 bytes) from udp/84.33.99.15:5060/sip next=(nil)

May be useful to understand why it does so? Registration requests seem to come. A freeswitch restart fixes the problem, at least for several hours then the problem comes back.

This server has been running perfectly for almost a year, i never updated anything, it has a lot of free space still on its memory.
 

Nedo

Member
Jun 22, 2020
59
3
8
40
Today happen again, server not register gateways (tryng) and not accepting extension connection until freeswitch restart, or system reboot.


tail -f /var/log/syslog
Jul 3 17:33:11 VoIP5 freeswitch[120565]: 2023-07-03 17:33:11.729639 94.77% [WARNING] sofia_reg.c:499 Timeout Registering 6d42a5d1-2f76-461d-936a-5992eed47c54
Jul 3 17:33:12 VoIP5 freeswitch[120565]: 2023-07-03 17:33:12.729645 94.67% [WARNING] sofia_reg.c:520 6d42a5d1-2f76-461d-936a-5992eed47c54 Failed Registration [908], setting retry to 30 seconds.
 

Nedo

Member
Jun 22, 2020
59
3
8
40
I have this extact problem:

My gateways cannot register with error 980:

freeswitch@CentralinoC9N> sofia status
Name Type Data State
=================================================================================================
external-ipv6 profile sip:mod_sofia@[::1]:5060 RUNNING (0)
external profile sip:mod_sofia@195.231.83.80:5080 RUNNING (8)
external::fc1fca91-4cc2-4287-8955-c45f5b52d6a7 gateway sip:xxxx@sip.mywic.it TRYING (retry: 2s)
internal profile sip:mod_sofia@195.231.83.80:5060 RUNNING (0


2023-07-04 11:53:26.491982 99.13% [WARNING] sofia_reg.c:499 Timeout Registering fc1fca91-4cc2-4287-8955-c45f5b52d6a7
2023-07-04 11:53:27.491975 99.07% [WARNING] sofia_reg.c:520 fc1fca91-4cc2-4287-8955-c45f5b52d6a7 Failed Registration [908], setting retry to 30 seconds.
2023-07-04 11:53:58.571978 98.90% [NOTICE] sofia_reg.c:463 Registering fc1fca91-4cc2-4287-8955-c45f5b52d6a7


I have deactivated iptables but the problem persist.
I can ping the gateway server without problem:

root@CentralinoC9N:~# ping sip.mywic.it
PING sip.messagenet.it (109.233.129.13) 56(84) bytes of data.
64 bytes from sip.messagenet.it (109.233.129.13): icmp_seq=1 ttl=56 time=9.77 ms
64 bytes from sip.messagenet.it (109.233.129.13): icmp_seq=2 ttl=56 time=9.95 ms
64 bytes from sip.messagenet.it (109.233.129.13): icmp_seq=3 ttl=56 time=9.84 ms
 
Status
Not open for further replies.