[OpenSIPS-Users] ERROR:presence:update_presentity cause OpenSIPS eat all memory and crash...

Bogdan-Andrei Iancu bogdan at opensips.org
Mon Mar 20 10:43:43 EDT 2017 

Michele,

I don;t think that the failed reconnect events are related to the OOM 
issue - to get some disconnection is normal if you have DB cons which 
are idle for longer period of time (hours). OpenSIPS will automatically 
attempt to re-connect / connect . Do you get these reconnect errors on 
daily bases ?

Regards,

Bogdan-Andrei Iancu
   OpenSIPS Founder and Developer
   http://www.opensips-solutions.com

OpenSIPS Summit May 2017 Amsterdam
   http://www.opensips.org/events/Summit-2017Amsterdam.html

On 03/16/2017 04:00 PM, Michele Pinassi wrote:
>
> More on this issue:
>
> /usr/sbin/opensips[1050]: 313438393637323537333232383031-kto38ogzez62 
> - Failure route 0 <null> <null>
> /usr/sbin/opensips[1052]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1052]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c8ec) 0xb7292054
> /usr/sbin/opensips[1052]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1049]: ERROR:presence:update_presentity: No E_Tag 
> match [a.1489656643.1049.47170.35]
> /usr/sbin/opensips[1047]: ERROR:presence:update_presentity: No E_Tag 
> match [a.1489656643.1047.47360.76]
> /usr/sbin/opensips[1048]: ERROR:presence:update_presentity: No E_Tag 
> match [a.1489656643.1047.47329.35]
> /usr/sbin/opensips[1050]: ERROR:presence:update_presentity: No E_Tag 
> match [a.1489656643.1047.47330.35]
> /usr/sbin/opensips[1052]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1052]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c8ec) 0xb7292054
> /usr/sbin/opensips[1052]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1052]: CRITICAL:db_mysql:db_mysql_submit_query: too 
> many mysql server reconnection failures
> /usr/sbin/opensips[1052]: ERROR:core:db_do_query: error while 
> submitting query - [select username,domain,etag,event from presentity 
> where expires<1489672563 order by username]
> /usr/sbin/opensips[1052]: ERROR:presence:msg_presentity_clean: 
> querying database for expired messages
> /usr/sbin/opensips[1052]: CRITICAL:core:timer_ticker: timer handler 
> <presence-pclean> lasted (3940000 us) for more than timer tick 
> (1000000 us) -> potential timer shifting
> /usr/sbin/opensips[1049]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1049]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c7e0) 0xb7292054
> /usr/sbin/opensips[1049]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1050]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1050]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c7e0) 0xb7292054
> /usr/sbin/opensips[1050]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1047]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1047]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c8ec) 0xb7292054
> /usr/sbin/opensips[1048]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1048]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c7e0) 0xb7292054
> /usr/sbin/opensips[1047]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1048]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1049]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1049]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c7e0) 0xb7292054
> /usr/sbin/opensips[1049]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1049]: CRITICAL:db_mysql:db_mysql_submit_query: too 
> many mysql server reconnection failures
> /usr/sbin/opensips[1049]: ERROR:core:db_do_update: error while 
> submitting query
> /usr/sbin/opensips[1049]: ERROR:presence:update_presentity: updating 
> published info in database
> /usr/sbin/opensips[1049]: ERROR:presence:handle_publish: when updating 
> presentity
> /usr/sbin/opensips[1050]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1050]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c7e0) 0xb7292054
> /usr/sbin/opensips[1050]: INFO:db_mysql:connect_with_retry: 
> re-connected successful for 0xb7292054
> /usr/sbin/opensips[1050]: CRITICAL:db_mysql:db_mysql_submit_query: too 
> many mysql server reconnection failures
> /usr/sbin/opensips[1050]: ERROR:core:db_do_update: error while 
> submitting query
> /usr/sbin/opensips[1050]: ERROR:presence:update_presentity: updating 
> published info in database
> /usr/sbin/opensips[1050]: ERROR:presence:handle_publish: when updating 
> presentity
> /usr/sbin/opensips[1047]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1047]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c8ec) 0xb7292054
> /usr/sbin/opensips[1048]: INFO:db_mysql:switch_state_to_disconnected: 
> disconnect event for 0xb7292054
> /usr/sbin/opensips[1048]: INFO:db_mysql:reset_all_statements: reseting 
> all statements on connection: (0xb728c7e0) 0xb7292054
> /usr/sbin/opensips[1049]: ERROR:presence:update_presentity: No E_Tag 
> match [a.1489656643.1047.47331.25]
> /usr/sbin/opensips[1048]: ERROR:presence:update_presentity: No E_Tag 
> match [a.1489656643.1050.47435.20]
>
> ....
>
> Michele
>
> On 16/03/2017 09:05, Michele Pinassi wrote:
>> Opensips 1.11.9-notls on a Debian 8.7 x64, with more that 700 phones
>> registered.
>>
>> Sometimes, almost twice a week, i got a lot of:
>>
>> /usr/sbin/opensips[1585]: ERROR:presence:update_presentity: No E_Tag
>> match [a.1489409482.1585.24993.147]
>> /usr/sbin/opensips[1586]: ERROR:presence:update_presentity: No E_Tag
>> match [a.1489409482.1584.24871.146]
>> /usr/sbin/opensips[1584]: ERROR:presence:update_presentity: No E_Tag
>> match [a.1489409482.1586.24799.146]
>>
>> that, after few hours, results in a:
>>
>> /usr/sbin/opensips[1585]: ERROR:tm:new_t: out of mem
>> /usr/sbin/opensips[1584]: WARNING:core:fm_malloc: Not enough free
>> memory, will attempt defragmentation
>> /usr/sbin/opensips[1585]: ERROR:tm:t_newtran: new_t failed
>> /usr/sbin/opensips[1584]: ERROR:tm:new_t: out of mem
>>
>> of course, users were not happy :-) so i need suggestions how to solve
>> the problem or how to avoid that error cause opensips to eat all the
>> memory available...
>>
>> Thanks, Michele
>>
>>
>>
>> _______________________________________________
>> Users mailing list
>> Users at lists.opensips.org
>> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>
> -- 
> Michele Pinassi
> Responsabile Telefonia di Ateneo
> Servizio Reti, Sistemi e Sicurezza Informatica - Università degli Studi di Siena
> tel: 0577.(23)5000 -centralino at unisi.it
>
> Per trovare una soluzione rapida ai tuoi problemi tecnici consulta le FAQ di Ateneo,http://www.faq.unisi.it  
>
>
> _______________________________________________
> Users mailing list
> Users at lists.opensips.org
> http://lists.opensips.org/cgi-bin/mailman/listinfo/users

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20170320/1f45c231/attachment.html>

More information about the Users mailing list