this is a more accurate debug trace:
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP Request:
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method: <INVITE>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri: <sip:+3481818181@146.185.142.19:9773>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version: <SIP/2.0>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjda85db1d-e415-410f-8f7d-d2e4b8ad6157>; state=16
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [receive.c:177]: receive_msg(): preparing to run routing scripts...
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=462 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=575 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=570 a=25 n=mf_process_maxfwd_header
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=580 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=575 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=580 a=26 n=sanity_check
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=9
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [32]; uri=[sip:+3481818181@146.185.142.19]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [sip:+3481818181@146.185.142.19#015#012]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <13850> <INVITE>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=476
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=42538f71-1d62-45a9-b994-bdb5876d7c3a
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=465 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=760 a=55 n=force_rport
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=771 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=761 a=25 n=nat_uac_test
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [msg_translator.c:158]: check_via_address(): (46.222.206.146, 46.222.206.146, 0)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=771 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=476 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=468 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=476 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=592 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=588 a=24 n=has_totag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: siputils [checks.c:97]: has_totag(): no totag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=588 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=485 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=481 a=24 n=t_precheck_trans
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=485 a=24 n=t_check_trans
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=3 global id=2 T start=0xffffffffffffffff
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=17941, isACK=0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=3 global id=3 T end=(nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=488 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=748 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=735 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 5060
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=754 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 5060
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=754 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=492 a=25 n=remove_hf
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=497 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=493 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=494 a=24 n=record_route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=502 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=497 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=498 a=39 n=setflag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=502 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[SIPOUT] c=[/etc/kamailio/kamailio.cfg] l=820 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[SIPOUT] c=[/etc/kamailio/kamailio.cfg] l=818 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=507 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[PRESENCE] c=[/etc/kamailio/kamailio.cfg] l=693 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[PRESENCE] c=[/etc/kamailio/kamailio.cfg] l=690 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[PRESENCE] c=[/etc/kamailio/kamailio.cfg] l=691 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=510 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REGISTRAR] c=[/etc/kamailio/kamailio.cfg] l=635 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REGISTRAR] c=[/etc/kamailio/kamailio.cfg] l=633 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[REGISTRAR] c=[/etc/kamailio/kamailio.cfg] l=633 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=519 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=519 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[PSTN] c=[/etc/kamailio/kamailio.cfg] l=857 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=522 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=663 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=659 a=25 n=alias_db_lookup
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:115]: db_new_result(): allocate 56 bytes for result set at 0x7f7db1e94d90
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 2 columns returned from the query
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:152]: db_allocate_columns(): allocate 16 bytes for result names at 0x7f7db1e93cf0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:163]: db_allocate_columns(): allocate 8 bytes for result types at 0x7f7db1e93d60
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7f7db1e6ec88
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): RES_NAMES(0x7f7db1e6ec88)[0]=[username]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7f7db1e6f840
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): RES_NAMES(0x7f7db1e6f840)[1]=[domain]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: db_mysql [km_res.c:168]: db_mysql_convert_rows(): no rows returned from the query
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: alias_db [alookup.c:117]: alias_db_lookup(): no alias found for R-URI
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 2 columns
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7f7db1e6ec88
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7f7db1e6f840
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7f7db1e93cf0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7f7db1e93d60
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7f7db1e94d90
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=663 a=63 n=assign
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=680 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=664 a=25 n=lookup
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: registrar [lookup.c:196]: lookup_helper(): contact for [+3481818181] found by address
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=684 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=680 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=681 a=39 n=setflag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=684 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=533 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=530 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=532 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=531 a=25 n=t_is_set
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=531 a=25 n=t_on_branch
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=536 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=533 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=535 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=534 a=25 n=t_is_set
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=534 a=25 n=t_on_reply
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=536 a=25 n=is_method
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=538 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=25 n=t_is_set
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=25 n=t_on_failure
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=543 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=24 n=t_relay
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=3 , global msg id=3 , T on entrance=(nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=17941, isACK=0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7f7da801f350, callback type 1, id 0 entered
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: 0db5f769d2a6f8e22f43cd18dc188e56
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_funcs.c:315]: t_relay_to(): SER: new INVITE
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [mem/shm_mem.c:101]: _shm_resize(): WARNING:vqm_resize: resize(0) called
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_reply.c:647]: _reply_light(): DEBUG: reply sent out. buf=0x7f7db1e94ec0: SIP/2.0 100 trying -..., shmem=0x7f7da8021f08: SIP/2.0 100 trying -
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_reply.c:657]: _reply_light(): DEBUG: _reply_light: finished
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=910 a=25 n=xdbg
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <script>: new branch [0] to sip:+3481818181@88.5.4.230:9773;ob
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=911 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=777 a=24 n=is_request
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=778 a=24 n=has_totag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: siputils [checks.c:97]: has_totag(): no totag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=787 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=41 n=isflagset
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=25 n=isbflagset
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=785 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: tm [t_funcs.c:362]: t_relay_to(): SER: new transaction fwd'ed
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=543 a=2 n=exit
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[797]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:616]: parse_msg(): SIP Reply (status):
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:618]: parse_msg(): version: <SIP/2.0>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:620]: parse_msg(): status: <100>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:622]: parse_msg(): reason: <Trying>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <146.185.142.19>; state=6
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK5164.0db5f769d2a6f8e22f43cd18dc188e56.0>; state=16
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=5 global id=4 T start=(nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <44637>; state=6
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <46.222.206.146>; state=6
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjda85db1d-e415-410f-8f7d-d2e4b8ad6157>; state=16
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=62
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:509]: parse_headers(): parse_headers: this is the second via
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=10
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [34]; uri=[sip:+3481818181@146.185.142.19]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [<sip:+3481818181@146.185.142.19>#015#012]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <13850> <INVITE>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_lookup.c:888]: t_reply_matching(): DEBUG: t_reply_matching: hash 17941 label 0 branch 0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_lookup.c:943]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7f7da801f350)!
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7f7da801f350, callback type 2, id 0 entered
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7f7da801f350) event type 2, reply code 100
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=5 global id=5 T end=0x7f7da801f350
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_reply.c:2154]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=0 local=0 is_invite=1)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=916 a=25 n=xdbg
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <script>: incoming reply
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=919 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=918 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=777 a=24 n=is_request
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=787 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=41 n=isflagset
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=25 n=isbflagset
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=785 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_reply.c:1232]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=100
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: tm [t_reply.c:1750]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=-1 icode=0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[796]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:616]: parse_msg(): SIP Reply (status):
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:618]: parse_msg(): version: <SIP/2.0>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:620]: parse_msg(): status: <500>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:622]: parse_msg(): reason: <>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <146.185.142.19>; state=6
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK5164.0db5f769d2a6f8e22f43cd18dc188e56.0>; state=16
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=5 global id=4 T start=(nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <44637>; state=6
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <46.222.206.146>; state=6
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjda85db1d-e415-410f-8f7d-d2e4b8ad6157>; state=16
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=62
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:509]: parse_headers(): parse_headers: this is the second via
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=65e14bd6-04f8-4235-8fb1-5bf452827546
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [75]; uri=[sip:+3481818181@146.185.142.19]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [<sip:+3481818181@146.185.142.19>]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <13850> <INVITE>
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_lookup.c:888]: t_reply_matching(): DEBUG: t_reply_matching: hash 17941 label 0 branch 0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_lookup.c:943]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7f7da801f350)!
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7f7da801f350, callback type 2, id 0 entered
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7f7da801f350) event type 2, reply code 500
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=5 global id=5 T end=0x7f7da801f350
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_reply.c:2154]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=100 local=0 is_invite=1)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=916 a=25 n=xdbg
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <script>: incoming reply
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=919 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_reply.c:1232]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=500
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7f7da801f350, callback type 128, id 0 entered
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7f7da801f350) event type 128, reply code 500
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: NOTICE: acc [acc.c:315]: acc_log_request(): ACC: call missed: timestamp=1515761540;method=INVITE;from_tag=42538f71-1d62-45a9-b994-bdb5876d7c3a;to_tag=65e14bd6-04f8-4235-8fb1-5bf452827546;call_id=0ba83c1c-1b50-4903-8f7c-ee602525316e;code=500;reason=;src_user=+34639446862;src_domain=146.185.142.19;src_ip=46.222.206.146;dst_ouser=+3481818181;dst_user=+3481818181;dst_domain=88.5.4.230
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 1
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 2
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 3
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 4
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 5
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[MANAGE_FAILURE] c=[/etc/kamailio/kamailio.cfg] l=923 a=5 n=route
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=777 a=24 n=is_request
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=778 a=24 n=has_totag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: siputils [checks.c:97]: has_totag(): no totag
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=787 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=41 n=isflagset
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=25 n=isbflagset
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=785 a=2 n=return
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[MANAGE_FAILURE] c=[/etc/kamailio/kamailio.cfg] l=946 a=16 n=if
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: exec: *** cfgtrace:failure_route=[MANAGE_FAILURE] c=[/etc/kamailio/kamailio.cfg] l=925 a=24 n=t_is_canceled
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=2 global id=2 T start=0x7f7da801f350
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_lookup.c:1083]: t_check_msg(): DEBUG: t_check_msg: T already found!
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_reply.c:1750]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [msg_translator.c:2229]: generate_res_buf_from_sip_res(): old size: 552, new size: 436
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [msg_translator.c:2246]: generate_res_buf_from_sip_res(): copied size: orig:130, new: 14, rest: 422 msg=#012SIP/2.0 500 #015#012Via: SIP/2.0/UDP 46.222.206.146:44637;rport=44637;received=46.222.206.146;branch=z9hG4bKPjda85db1d-e415-410f-8f7d-d2e4b8ad6157#015#012Record-Route: <sip:146.185.142.19:9773;lr>#015#012Call-ID: 0ba83c1c-1b50-4903-8f7c-ee602525316e#015#012From: <sip:+34639446862@146.185.142.19>;tag=42538f71-1d62-45a9-b994-bdb5876d7c3a#015#012To: <sip:+3481818181@146.185.142.19>;tag=65e14bd6-04f8-4235-8fb1-5bf452827546#015#012CSeq: 13850 INVITE#015#012Content-Length: 0
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7f7da801f350, callback type 512, id 0 entered
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7f7da801f350) event type 512, reply code 500
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: tm [t_reply.c:1591]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Jan 12 12:52:20 kamailio-alone /usr/sbin/kamailio[795]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
The 500 code seems to be sent indeed by client (using pjsip).
—
You are receiving this because you are subscribed to this thread.
Reply to this email directly, view it on GitHub, or mute the thread.