[OpenSIPS-Users] MSILO Module can't work
Bogdan-Andrei Iancu
bogdan at opensips.org
Wed Feb 4 09:26:10 CET 2015
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:003 at 118.193.154.214 <mailto:003 at 118.193.154.214>
> 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:003 at 118.193.154.214 <mailto:003 at 118.193.154.214>> 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:010 at 118.193.154.214 <mailto:010 at 118.193.154.214>]
> Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]:
> DBG:db_mysql:db_mysql_str2val: converting STRING
> [sip:003 at 118.193.154.214 <mailto:003 at 118.193.154.214>]
> 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:010 at 118.193.154.214 <mailto:010 at 118.193.154.214>]
> Feb 4 11:38:23 mySer /usr/sbin/opensips[14888]:
> DBG:db_mysql:db_mysql_str2val: converting STRING
> [sip:003 at 118.193.154.214 <mailto:003 at 118.193.154.214>]
> ] 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:003 at 118.193.154.214
> <mailto:003 at 118.193.154.214>>!!!
> 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" <bogdan at opensips.org
> <mailto:bogdan at opensips.org>> 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
>
>
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20150204/619b8070/attachment.htm>
More information about the Users
mailing list