Thanks Daniel. UDP is the same story as TCP and TLS, unfortunately.
Looking through the logs, I see strange errors in parsing the contact header when msilo prepares to send the notification back to 1000. This is for the notification message that should have been sent back to 1000 after he sent a message to 1010 (offline). I also see that kamailio reports that 1000's location was not found, even though he's obviously registered.
The more I play around with this, the more confused I become.
Do you think this contact parsing error could be the root of the problems?
Cheers, Peter
Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:623]: parse_msg(): SIP Request: Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:625]: parse_msg(): method: <MESSAGE> Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:627]: parse_msg(): uri: sip:1000@my.domain.com Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:629]: parse_msg(): version: <SIP/2.0> Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/parse_via.c:1284]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK90dc.68116a97000000000000000000000000.0>; state=16 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/parse_via.c:2672]: parse_via(): end of header reached, state=5 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers(): parse_headers: Via found, flags=2 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:515]: parse_headers(): parse_headers: this is the first via Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [receive.c:152]: receive_msg(): After parse_msg... Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [receive.c:193]: receive_msg(): preparing to run routing scripts... Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=10 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:190]: get_hdr_field(): DEBUG: get_hdr_field: <To> [28]; uri=[sip:1000@my.domain.com] Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:192]: get_hdr_field(): DEBUG: to body [< sip:1000@my.domain.com>#015#012] Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:170]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <10> <MESSAGE> Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body : content_length=25 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG: add_param: tag=533cb9e91f4b999cf76861cbb9ed54ed-bb2e Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [parser/parse_addr_spec.c:893]: parse_addr_spec(): end of header reached, state=29 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: sanity [mod_sanity.c:255]: w_sanity_check(): sanity checks result: 1 Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: siputils [sipops.c:161]: w_is_first_hop(): no 2nd via found - first hop Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: *ERROR: <core> [parser/contact/contact.c:175]: skip_name(): skip_name(): Error in contact, scheme separator not found* Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: ERROR: <core> [parser/contact/contact.c:202]: parse_contacts(): parse_contacts(): Error while skipping name part Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: ERROR: <core> [parser/contact/parse_contact.c:59]: contact_parser(): contact_parser(): Error while parsing contacts Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: ERROR: <core> [parser/contact/parse_contact.c:88]: parse_contact(): parse_contact(): Error while parsing Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: ERROR: nathelper [nhelpr_funcs.c:300]: get_contact_uri(): failed to parse Contact body Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: siputils [checks.c:103]: has_totag(): no totag Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: NOTICE: <script>: !------------------------------------>WE HAVE A NEW MESSAGE Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: registrar [lookup.c:181]: *lookup(): contact for [1000] found by address* Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==9 && [79.my.server.IP1] == [127.0.0.1] Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): grep_sock_info - checking if host==us: 14==14 && [79.my.server.IP1] == [79.my.server.IP1] Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: NOTICE: <script>: ------------------MESSAGE PROCESSING: *location not found*, storing offline message ID: (sip:1000@85.xx.xx.xx:59287;transport=TLS) Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: msilo [msilo.c:605]: m_store(): ------------ start ------------ Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: msilo [msilo.c:648]: m_store(): using user id [sip:1000@85.xx.xx.xx:59287;transport=TLS] Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: msilo [msilo.c:732]: m_store(): 'From' header: sip:registrar@my.domain.com Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: msilo [msilo.c:849]: m_store(): message stored. T:sip:1000@my.domain.com F:< sip:registrar@my.domain.com> Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: msilo [msilo.c:858]: m_store(): sending info message. Jul 18 15:50:32 pbx /usr/sbin/kamailio[12600]: DEBUG: msilo [msilo.c:899]: m_store(): contact header found
On Thu, Jul 17, 2014 at 11:01 PM, Daniel-Constantin Mierla < miconda@gmail.com> wrote:
You should not call m_store() if src_ip==myself -- in this way you avoid to store notification messages that cannot be delivered.
Why notifications are not delivered has to be troubleshooted there. Have you tried also with UDP?
Cheers, Daniel