Hi Tin,

I see these logs :
DBG:msilo:m_dump: message[0] mid=4836 already sent.

The module keeps an in-memory list with the messages which were already sent out. It seems OpenSIPS did send the messages out, at some time before this attempt.

Do a fresh restart of opensips (to clear the memory list) and grab the logs for the first REGISTER.

Regards,

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

On 04.02.2015 07:47, tin wrote:
Hi,Bogdan:
        the e-mail is too big ,so i have to send you two,this is two.
        2)this code add to the script:
                xlog("m_dump is starting!!");
                 setdebug(4);
                 m_dump();
                 setdebug();
                xlog("m_dump was end!!");

And the user 003 was didn't receive the offline message;another i should see the log like below:

Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: Register ok :sip:[email protected] <mailto:[email protected]>
Feb  4 11:38:23 mySer /usr/sbin/opensips[14888]: m_dump is starting!!
Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:parse_headers: flags=8000 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:m_dump: user <sip:[email protected] <mailto:[email protected]>> online - expires=3600 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:parse_headers: flags=ffffffffffffffff Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:parse_headers: flags=ffffffffffffffff Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:check_message_support: Allow message: 0 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:parse_headers: flags=80 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:get_hdr_field: found end of header Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:mysql_raise_event: MySQL status has not changed: connected Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_new_result: allocate 48 bytes for result set at 0x2ac45c768a80 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: 6 columns returned from the query Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_allocate_columns: allocate 168 bytes for result columns at 0x2ac45c768148 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x2ac45c768178)[0]=[id] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x2ac45c768188)[1]=[src_addr] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x2ac45c768198)[2]=[dst_addr] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x2ac45c7681a8)[3]=[body] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: use DB_BLOB result type Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x2ac45c7681b8)[4]=[ctype] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x2ac45c7681c8)[5]=[inc_time] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_get_columns: use DB_INT result type Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_allocate_rows: allocate 416 bytes for result rows and values at 0x2ac45c7665d8 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting INT [4836] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting STRING [sip:[email protected] <mailto:[email protected]>] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting STRING [sip:[email protected] <mailto:[email protected]>] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting BLOB [<?xml version='1.0' encoding='UTF-8'?> <isComposing xmlns='urn:ietf:params:xml:ns:im-iscomposing' xmlns:xsi='http://www.w3.org/2001/XMLSchema-instance'> <state>active</state> <contenttype>text/plain</contenttype> <refresh>60</refresh> </isComposing>] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting STRING [application/im-iscomposing+xml] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting INT [1423019838] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting INT [4838] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting STRING [sip:[email protected] <mailto:[email protected]>] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting STRING [sip:[email protected] <mailto:[email protected]>] ] 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting BLOB [hi,i am 010! Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting STRING [text/plain] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:db_mysql:db_mysql_str2val: converting INT [1423019849] Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:m_dump: dumping [2] messages for <sip:[email protected] <mailto:[email protected]>>!!! Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:msg_list_check_msg: checking msgid=4836 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:msg_list_check_msg: msg already in sent list. Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:m_dump: message[0] mid=4836 already sent. Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:msg_list_check_msg: checking msgid=4838 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:msg_list_check_msg: msg already in sent list. Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:msilo:m_dump: message[1] mid=4838 already sent. Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_free_columns: freeing result columns at 0x2ac45c768148 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_free_rows: freeing 2 rows Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_free_row: freeing row values at 0x2ac45c7665f8 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_free_row: freeing row values at 0x2ac45c7666b8 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_free_rows: freeing rows at 0x2ac45c7665d8 Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]: DBG:core:db_free_result: freeing result set at 0x2ac45c768a80
Feb  4 11:38:23 mySer /usr/sbin/opensips[14888]: m_dump was end!!

thanks a lot! i need your help!


At 2015-02-03 18:05:43, "Bogdan-Andrei Iancu" <[email protected] <mailto:[email protected]>> wrote:

    Hi Tin,

    Once again, can you post the full REGISTER request here ? are you
    sure that REGISTER do advertise "MESSAGE" in the Allow header

    Also , you could enable full debug for the m_dump() function:
        set_debug(4);
        m_dump();
        set_debug();

    In this case, you may get a clue why the function does not send
    out the stored messages.

    Regards,

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





_______________________________________________
Users mailing list
[email protected]
http://lists.opensips.org/cgi-bin/mailman/listinfo/users

Reply via email to