Re: [OpenSIPS-Users] What does happen when location table has records for peer that is offline?
Hi Rodrigo, Yes, probably there were TCP contacts left over in location table - and when OpenSIPS was trying to use them, it was attempting to open a TCP connection to the IP indicated by the contact (where of course, nobody was listening). That is SIP :). Maybe you should try to lower the registration duration for TCP contacts. OR , if using 2.2, you can do pinging with auto-removal of un-reachable contacts. Regards, Bogdan-Andrei Iancu OpenSIPS Founder and Developer http://www.opensips-solutions.com On 04.10.2016 16:26, Rodrigo Pimenta Carvalho wrote: Hi. In my table location (in OpenSIPS) I found some records for a peer that was not online. That is, some peer offline let some registers in the location table. For example: the peer A registered itself using several different devices, then turned off all of such devices. Such records would expires sometime in the future. Then, peer B called A, and in this moment I saw a log with several erros, from OpenSIPs. Does such logs relates to these invalid records in table location? After removing these records (opensipsctl ul rm ) those messages stopped appearing in the log. See the log below. Any hint will be very helpful! Best regards. RODRIGO PIMENTA CARVALHO Inatel Competence Center Software Ph: +55 35 3471 9200 RAMAL 979 Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:47340;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:54112;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:38220;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:54112;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:38220;transport=TCP;ob Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 21 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: poll error: flags 1c Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: failed to retrieve SO_ERROR [server=127.0.0.1:47340] (111) Connection refused Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:proto_tcp_send: async TCP connect failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:msg_send: send() for proto 2 failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:t_forward_nonack: sending request failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 21 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: poll error: flags 1c Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: failed to retrieve SO_ERROR [server=127.0.0.1:54112] (111) Connection refused Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:proto_tcp_send: async TCP connect failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:msg_send: send() for proto 2 failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:t_forward_nonack: sending request failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 21 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: poll error: flags 1c Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: failed to retrieve SO_ERROR [server=127.0.0.1:54112] (111) Connection refused Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:proto_tcp_send: async TCP connect failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:msg_send: send() for proto 2 failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:t_forward_nonack: sending request failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 23 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] ERROR:c
[OpenSIPS-Users] What does happen when location table has records for peer that is offline?
Hi. In my table location (in OpenSIPS) I found some records for a peer that was not online. That is, some peer offline let some registers in the location table. For example: the peer A registered itself using several different devices, then turned off all of such devices. Such records would expires sometime in the future. Then, peer B called A, and in this moment I saw a log with several erros, from OpenSIPs. Does such logs relates to these invalid records in table location? After removing these records (opensipsctl ul rm ) those messages stopped appearing in the log. See the log below. Any hint will be very helpful! Best regards. RODRIGO PIMENTA CARVALHO Inatel Competence Center Software Ph: +55 35 3471 9200 RAMAL 979 Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:47340;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:54112;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:38220;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:54112;transport=TCP;ob Jan 01 01:19:16 colibri-imx6 opensips[609]: new branch at sip:g1r2u3p4o5@127.0.0.1:38220;transport=TCP;ob Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 21 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: poll error: flags 1c Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: failed to retrieve SO_ERROR [server=127.0.0.1:47340] (111) Connection refused Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:proto_tcp_send: async TCP connect failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:msg_send: send() for proto 2 failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:t_forward_nonack: sending request failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 21 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: poll error: flags 1c Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: failed to retrieve SO_ERROR [server=127.0.0.1:54112] (111) Connection refused Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:proto_tcp_send: async TCP connect failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:msg_send: send() for proto 2 failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:t_forward_nonack: sending request failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 21 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: poll error: flags 1c Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:tcpconn_async_connect: failed to retrieve SO_ERROR [server=127.0.0.1:54112] (111) Connection refused Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:core:proto_tcp_send: async TCP connect failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:msg_send: send() for proto 2 failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [616] ERROR:tm:t_forward_nonack: sending request failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] INFO:core:probe_max_sock_buff: using snd buffer of 320 kb Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] INFO:core:init_sock_keepalive: TCP keepalive enabled on socket 23 Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] ERROR:core:tcpconn_async_connect: poll error: flags 1c Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] ERROR:core:tcpconn_async_connect: failed to retrieve SO_ERROR [server=127.0.0.1:47340] (111) Connection refused Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] ERROR:core:proto_tcp_send: async TCP connect failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] ERROR:tm:msg_send: send() for proto 2 failed Jan 01 01:19:17 colibri-imx6 opensips[609]: Jan 1 01:19:16 [617] ERROR:tm:t_forward_nonack: sending request failed Jan 01 01:19:17 colibri-imx6 opensips[609]:
