These are the complete logs for the previous call:

Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [io_wait.h:598]: io_watch_del(): DBG: io_watch_del (0xa28d40, 29, -1, 0x0) fd_no=21 called
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:4131]: handle_tcpconn_ev(): sending to child, events 1
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3810]: send2child(): selected tcp worker 1 11(3099) for activity on [tcp:146.185.142.19:9773], 0x7fa00bf44ae0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1539]: handle_io(): received n=8 con=0x7fa00bf44ae0, fd=9
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=479
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP Request:
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:608]: parse_msg():  method:  <INVITE>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  uri:     <sip:+3412345678910@146.185.142.19:9773>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  version: <SIP/2.0>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63>
; state=6
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:177]: receive_msg(): preparing to run routing scripts...
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=466 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=574 a=25 n=mf_process_maxfwd_header
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=588 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=26 n=sanity_check
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=9
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [35]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [sip:+3412345678910@146.185.142.19#015#012]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21647> <INVITE>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=479
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=469 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=764 a=55 n=force_rport
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=765 a=25 n=nat_uac_test
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:158]: check_via_address(): (37.29.170.95, 37.29.170.95, 0)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=472 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=592 a=24 n=has_totag
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:97]: has_totag(): no totag
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=592 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=489 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=485 a=24 n=t_precheck_trans
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=489 a=24 n=t_check_trans
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=9 T start=(nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=7756, isACK=0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=10 T end=(nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=492 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=752 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=739 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 5060
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 5060
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=758 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 5060
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 5060
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[AUTH] c=[/etc/kamailio/kamailio.cfg] l=758 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=496 a=25 n=remove_hf
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=501 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=497 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=498 a=24 n=record_route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=506 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=501 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=502 a=39 n=setflag
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=506 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[SIPOUT] c=[/etc/kamailio/kamailio.cfg] l=828 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[SIPOUT] c=[/etc/kamailio/kamailio.cfg] l=826 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=511 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[PRESENCE] c=[/etc/kamailio/kamailio.cfg] l=697 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[PRESENCE] c=[/etc/kamailio/kamailio.cfg] l=694 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[PRESENCE] c=[/etc/kamailio/kamailio.cfg] l=695 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=514 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REGISTRAR] c=[/etc/kamailio/kamailio.cfg] l=639 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REGISTRAR] c=[/etc/kamailio/kamailio.cfg] l=637 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REGISTRAR] c=[/etc/kamailio/kamailio.cfg] l=637 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=523 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=523 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[PSTN] c=[/etc/kamailio/kamailio.cfg] l=865 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=526 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=667 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=663 a=25 n=alias_db_lookup
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:115]: db_new_result(): allocate 56 bytes for result set at 0x7fa015dc2c48
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 2 columns returned from the query
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:152]: db_allocate_columns(): allocate 16 bytes for result names at 0x7fa015dc2d50
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:163]: db_allocate_columns(): allocate 8 bytes for result types at 0x7fa015dc2dc0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7fa015dc2e28
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): RES_NAMES(0x7fa015dc2e28)[0]=[username]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:83]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7fa015dc2e98
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:90]: db_mysql_get_columns(): RES_NAMES(0x7fa015dc2e98)[1]=[domain]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: db_mysql [km_res.c:168]: db_mysql_convert_rows(): no rows returned from the query
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: alias_db [alookup.c:117]: alias_db_lookup(): no alias found for R-URI
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 2 columns
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7fa015dc2e28
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7fa015dc2e98
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7fa015dc2d50
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7fa015dc2dc0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7fa015dc2c48
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=667 a=63 n=assign
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=684 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=668 a=25 n=lookup
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: registrar [lookup.c:196]: lookup_helper(): contact for [+3412345678910] found by address
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=688 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=684 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=685 a=39 n=setflag
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[LOCATION] c=[/etc/kamailio/kamailio.cfg] l=688 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=534 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=536 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=535 a=25 n=t_is_set
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=535 a=25 n=t_on_branch
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=539 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=538 a=25 n=t_is_set
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=538 a=25 n=t_on_reply
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=25 n=is_method
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=542 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=541 a=25 n=t_is_set
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=541 a=25 n=t_on_failure
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=24 n=t_relay
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=10 , global msg id=10 , T on entrance=(nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=7756, isACK=0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 1, id 0 entered
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: f3913fdf4b6cd76583034cec844eb6cd
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_funcs.c:315]: t_relay_to(): SER: new INVITE
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [mem/shm_mem.c:101]: _shm_resize(): WARNING:vqm_resize: resize(0) called
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2195]: tcpconn_send_put(): send from reader (3099 (11)), reusing fd
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf44ae0 n=430 fd=9
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012SIP/2.0 100 trying -- your call is important to us#015#012Via: SIP/2.0/TCP 37.29
.170.95:33335;rport=33335;branch=z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63;alias;received=37.29.170.95#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#
012To: sip:+3412345678910@146.185.142.19#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21647 INVITE#015#012Server: kamailio (4.3.4 (x86_64/linux))#015#012Content-Length: 0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_reply.c:647]: _reply_light(): DEBUG: reply sent out. buf=0x7fa015dc30b0: SIP/2.0 100 trying -..., shmem=0x7fa00bf4c3f8: SIP/2.0
 100 trying -
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_reply.c:657]: _reply_light(): DEBUG: _reply_light: finished
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=918 a=25 n=xdbg
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <script>: new branch [0] to sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=919 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=789 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=24 n=has_totag
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:97]: has_totag(): no totag
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:2843]: create_via_hf(): id added: <;i=5>, rcv proto=2
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2211]: tcpconn_send_put(): tcp connection found (0x7fa00bf40488), acquiring fd
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3475]: handle_ser_child(): read response= 7fa00bf40488, 2, fd -1 from 11 (3099)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2221]: tcpconn_send_put(): c=0x7fa00bf40488, n=16
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2251]: tcpconn_send_put(): after receive_fd: c= 0x7fa00bf40488 n=8 fd=11
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf40488 n=1340 fd=11
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012INVITE sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob SIP/2.0#015#012Rec
ord-Route: <sip:146.185.142.19:9773;transport=tcp;lr>#015#012Via: SIP/2.0/TCP 146.185.142.19:9773;branch=z9hG4bKc4e1.f3913fdf4b6cd76583034cec844eb6cd.0;i=5#015#012Via: SIP/2.0/TCP 37.29.170.95:3333
5;received=37.29.170.95;rport=33335;branch=z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63;alias#015#012Max-Forwards: 69#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b
2ee4f40#015#012To: sip:+3412345678910@146.185.142.19#015#012Contact: <sip:+34639446862@37.29.170.95:33335;transport=TCP;ob>#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21647 I
NVITE#015#012Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS#015#012Supported: replaces, 100rel, timer, norefersub#015#012Session-Expires: 1800#015#
012Min-SE: 90#015#012Content-Type: application/sdp#015#012Content-Length:   479#015#012#015#012v=0#015#012o=- 3727693372 3727693372 IN IP4 100.108.48.229#015#012s=pjmedia#015#012b=AS:84#015#012t=0 
0#015#012a=X-nat:0#015#012m=audio 4004 RTP/AVP 98 97 99 104 3 0 8 9 96#015#012c=IN IP4 100.108.48.229#015#012b=TIAS:64000#015#012a=rtcp:4005 IN IP4 100.108.48.229#015#012a=sendrecv#015#012a=rtpmap:
98 speex/16000#015#012a=rtpmap:97 speex/8000#015#012a=rtpmap:99 speex/32000#015#012a=rtpmap:104 iLBC/8000#015#012a=fmtp:104 mode=30#015#012a=rtpmap:3 GSM/8000#015#012a=rtpmap:0 PCMU/8000#015#012a=r
tpmap:8 PCMA/8000#015#012a=rtpmap:9 G722/8000#015#012a=rtpmap:96 telephone-event/8000#015#012a=fmtp:96 0-16
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_funcs.c:362]: t_relay_to(): SER: new transaction fwd'ed
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=2 n=exit
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [io_wait.h:376]: io_watch_add(): DBG: io_watch_add(0xa81660, 9, 2, 0x7fa00bf44ae0), fd_no=1
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [io_wait.h:598]: io_watch_del(): DBG: io_watch_del (0xa28d40, 28, -1, 0x0) fd_no=20 called
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:4131]: handle_tcpconn_ev(): sending to child, events 1
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3810]: send2child(): selected tcp worker 2 12(3100) for activity on [tcp:146.185.142.19:9773], 0x7fa00bf40488
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_read.c:1539]: handle_io(): received n=8 con=0x7fa00bf40488, fd=9
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:616]: parse_msg(): SIP Reply  (status):
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:618]: parse_msg():  version: <SIP/2.0>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:620]: parse_msg():  status:  <100>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:622]: parse_msg():  reason:  <Trying>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <146.185.142.19>; state=6
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKc4e1.f3913fdf4b6cd76583034cec844eb6cd.0
>; state=6
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 236, <i> = <5>; state=16
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=7 global id=6 T start=(nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <33335>; state=6
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <37.29.170.95>; state=6
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63>
; state=6
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=62
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:509]: parse_headers(): parse_headers: this is the second via
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=10
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [37]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [<sip:+3412345678910@146.185.142.19>#015#012]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21647> <INVITE>
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:888]: t_reply_matching(): DEBUG: t_reply_matching: hash 7756 label 0 branch 0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:943]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fa00bf492c0)!
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 2, id 0 entered
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7fa00bf492c0) event type 2, reply code 100
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=7 global id=7 T end=0x7fa00bf492c0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:2154]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=0 local=0 is_invite=1)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=924 a=25 n=xdbg
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <script>: incoming reply
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=927 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=926 a=5 n=route
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1232]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=100
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1750]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=-1 icode=0
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:22:54 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [io_wait.h:376]: io_watch_add(): DBG: io_watch_add(0xa81660, 9, 2, 0x7fa00bf40488), fd_no=1
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=275
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:616]: parse_msg(): SIP Reply  (status):
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:618]: parse_msg():  version: <SIP/2.0>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:620]: parse_msg():  status:  <200>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:622]: parse_msg():  reason:  <OK>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <146.185.142.19>; state=6
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKc4e1.f3913fdf4b6cd76583034cec844eb6cd.0
>; state=6
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 236, <i> = <5>; state=16
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=7 T start=0xffffffffffffffff
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <33335>; state=6
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <37.29.170.95>; state=6
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63>
; state=6
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=62
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:509]: parse_headers(): parse_headers: this is the second via
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [78]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [<sip:+3412345678910@146.185.142.19>]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21647> <INVITE>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:888]: t_reply_matching(): DEBUG: t_reply_matching: hash 7756 label 0 branch 0
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:943]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fa00bf492c0)!
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 2, id 0 entered
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7fa00bf492c0) event type 2, reply code 200
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=8 global id=8 T end=0x7fa00bf492c0
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:2154]: reply_received(): DEBUG: reply_received: org. status uas=100, uac[0]=100 local=0 is_invite=1)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=924 a=25 n=xdbg
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <script>: incoming reply
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=927 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=926 a=5 n=route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1232]: t_should_relay_response(): ->>>>>>>>> T_code=100, new_code=200
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1750]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=275
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [msg_translator.c:2229]: generate_res_buf_from_sip_res(): old size: 1152, new size: 1032
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [msg_translator.c:2246]: generate_res_buf_from_sip_res(): copied size: orig:136, new: 16, rest: 1016 msg=#012SIP/2.0 200 OK#01
5#012Via: SIP/2.0/TCP 37.29.170.95:33335;rport=33335;received=37.29.170.95;branch=z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63;alias#015#012Record-Route: <sip:146.185.142.19:9773;transport=tcp;lr>
#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012From: <sip:+34639446862@146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: <sip:+3412345678910@146.185.142.19>;tag=8abc
c3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21647 INVITE#015#012Contact: <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>#015#012Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBS
CRIBE, NOTIFY, REFER, MESSAGE, OPTIONS#015#012Supported: replaces, 100rel, timer, norefersub#015#012Session-Expires: 1800;refresher=uac#015#012Require: timer#015#012Content-Type: application/sdp#01
5#012Content-Length:   275#015#012#015#012v=0#015#012o=- 3727693379 3727693380 IN IP4 192.168.1.35#015#012s=pjmedia#015#012b=AS:84#015#012t=0 0#015#012a=X-nat:0#015#012m=audio 4002 RTP/AVP 98 96#01
5#012c=IN IP4 192.168.1.35#015#012b=TIAS:64000#015#012a=rtcp:4003 IN IP4 192.168.1.35#015#012a=sendrecv#015#012a=rtpmap:98 speex/16000#015#012a=rtpmap:96 telephone-event/8000#015#012a=fmtp:96 0-16
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:335]: update_totag_set(): DEBUG: update_totag_set: new totag
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2211]: tcpconn_send_put(): tcp connection found (0x7fa00bf44ae0), acquiring fd
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3475]: handle_ser_child(): read response= 7fa00bf44ae0, 2, fd -1 from 12 (3100)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2221]: tcpconn_send_put(): c=0x7fa00bf44ae0, n=16
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2251]: tcpconn_send_put(): after receive_fd: c= 0x7fa00bf44ae0 n=8 fd=12
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf44ae0 n=1032 fd=12
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012SIP/2.0 200 OK#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;rport=33335;receive
d=37.29.170.95;branch=z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63;alias#015#012Record-Route: <sip:146.185.142.19:9773;transport=tcp;lr>#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015
#012From: <sip:+34639446862@146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: <sip:+3412345678910@146.185.142.19>;tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21647 IN
VITE#015#012Contact: <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>#015#012Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS#015#012Suppo
rted: replaces, 100rel, timer, norefersub#015#012Session-Expires: 1800;refresher=uac#015#012Require: timer#015#012Content-Type: application/sdp#015#012Content-Length:   275#015#012#015#012v=0#01
5#012o=- 3727693379 3727693380 IN IP4 192.168.1.35#015#012s=pjmedia#015#012b=AS:84#015#012t=0 0#015#012a=X-nat:0#015#012m=audio 4002 RTP/AVP 98 96#015#012c=IN IP4 192.168.1.35#015#012b=TIAS:6400
0#015#012a=rtcp:4003 IN IP4 192.168.1.35#015#012a=sendrecv#015#012a=rtpmap:98 speex/16000#015#012a=rtpmap:96 telephone-event/8000#015#012a=fmtp:96 0-16
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 512, id 0 entered
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7fa00bf492c0) event type 512, reply code 200
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 0
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 1
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 2
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 3
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 4
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 5
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1591]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=0
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP Request:
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:608]: parse_msg():  method:  <ACK>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  uri:     <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  version: <SIP/2.0>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj65ee4cd6-1345-4e0a-ba78-07849b77ab
0e>; state=6
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:177]: receive_msg(): preparing to run routing scripts...
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: sl [sl_funcs.c:388]: sl_filter_ACK(): DEBUG : sl_filter_ACK: to late to be a local ACK!
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=466 a=5 n=route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=574 a=25 n=mf_process_maxfwd_header
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=25 n=is_method
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=588 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=26 n=sanity_check
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [76]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [sip:+3412345678910@146.185.142.19]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21647> <ACK>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=469 a=5 n=route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=764 a=55 n=force_rport
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=765 a=25 n=nat_uac_test
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:158]: check_via_address(): (37.29.170.95, 37.29.170.95, 0)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=2 n=return
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=472 a=25 n=is_method
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=5 n=route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=592 a=24 n=has_totag
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=614 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=24 n=loose_route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:88]: is_preloaded(): is_preloaded: No
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:782]: after_loose(): Topmost route URI: 'sip:146.185.142.19:9773;transport=tcp;lr' is me
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:179]: find_next_route(): No next Route HF found
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:807]: after_loose(): No next URI found
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=597 a=5 n=route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=817 a=24 n=isdsturiset
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=818 a=24 n=handle_ruri_alias
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: nathelper [nathelper.c:1261]: handle_ruri_alias_f(): no alias param
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=2 n=return
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=598 a=25 n=is_method
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=602 a=25 n=is_method
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=604 a=5 n=route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=789 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=24 n=has_totag
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=788 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=785 a=25 n=check_route_param
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:985]: check_route_param(): params are <;transport=tcp;lr>
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=5 n=route
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=534 a=25 n=is_method
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=25 n=is_method
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=25 n=is_method
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=16 n=if
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=24 n=t_relay
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=11 , global msg id=10 , T on entrance=0xffffffffffffffff
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=7756, isACK=1
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_funcs.c:279]: t_relay_to(): SER: forwarding ACK  statelessly
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: 0c9c2ef949368b5bf49c058f04a754ca
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:2843]: create_via_hf(): id added: <;i=5>, rcv proto=2
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:556]: forward_request(): Sending:#012ACK sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob SIP/2.0#015#012V
ia: SIP/2.0/TCP 146.185.142.19:9773;branch=z9hG4bKc4e1.0c9c2ef949368b5bf49c058f04a754ca.0;i=5#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;received=37.29.170.95;rport=33335;branch=z9hG4bKPj65ee4cd
6-1345-4e0a-ba78-07849b77ab0e;alias#015#012Max-Forwards: 69#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: sip:+3412345678910@146.185.142.19;tag
=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21647 ACK#015#012Content-Length:  0#015#012#015#012.
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:557]: forward_request(): orig. len=485, new_len=558, proto=2
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2208]: tcpconn_send_put(): found fd in cache (11, 0x7fa00bf40488, 6)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf40488 n=558 fd=11
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012ACK sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob SIP/2.0#015#012Via
: SIP/2.0/TCP 146.185.142.19:9773;branch=z9hG4bKc4e1.0c9c2ef949368b5bf49c058f04a754ca.0;i=5#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;received=37.29.170.95;rport=33335;branch=z9hG4bKPj65ee4cd6-
1345-4e0a-ba78-07849b77ab0e;alias#015#012Max-Forwards: 69#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: sip:+3412345678910@146.185.142.19;tag=8
abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21647 ACK#015#012Content-Length:  0
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:22:55 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=275
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:616]: parse_msg(): SIP Reply  (status):
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:618]: parse_msg():  version: <SIP/2.0>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:620]: parse_msg():  status:  <200>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:622]: parse_msg():  reason:  <OK>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <146.185.142.19>; state=6
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKc4e1.f3913fdf4b6cd76583034cec844eb6c
d.0>; state=6
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 236, <i> = <5>; state=16
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=9 global id=8 T start=0xffffffffffffffff
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <33335>; state=6
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <37.29.170.95>; state=6
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a
63>; state=6
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=62
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:509]: parse_headers(): parse_headers: this is the second via
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [78]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [<sip:+3412345678910@146.185.142.19>]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21647> <INVITE>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:888]: t_reply_matching(): DEBUG: t_reply_matching: hash 7756 label 0 branch 0
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:943]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fa00bf492c0)!
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 2, id 0 entered
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7fa00bf492c0) event type 2, reply code 200
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=9 global id=9 T end=0x7fa00bf492c0
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:2154]: reply_received(): DEBUG: reply_received: org. status uas=200, uac[0]=200 local=0 is_invite=1)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=924 a=25 n=xdbg
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <script>: incoming reply
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=927 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[MANAGE_REPLY] c=[/etc/kamailio/kamailio.cfg] l=926 a=5 n=route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: exec: *** cfgtrace:onreply_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1232]: t_should_relay_response(): ->>>>>>>>> T_code=200, new_code=200
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1237]: t_should_relay_response(): DBG: t_should_relay_response: 200 INV after final sent
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1750]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=275
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [msg_translator.c:2229]: generate_res_buf_from_sip_res(): old size: 1152, new size: 1032
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [msg_translator.c:2246]: generate_res_buf_from_sip_res(): copied size: orig:136, new: 16, rest: 1016 msg=#012SIP/2.0 200 OK#01
5#012Via: SIP/2.0/TCP 37.29.170.95:33335;rport=33335;received=37.29.170.95;branch=z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63;alias#015#012Record-Route: <sip:146.185.142.19:9773;transport=tcp;lr>
#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012From: <sip:+34639446862@146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: <sip:+3412345678910@146.185.142.19>;tag=8abc
c3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21647 INVITE#015#012Contact: <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>#015#012Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBS
CRIBE, NOTIFY, REFER, MESSAGE, OPTIONS#015#012Supported: replaces, 100rel, timer, norefersub#015#012Session-Expires: 1800;refresher=uac#015#012Require: timer#015#012Content-Type: application/sdp#01
5#012Content-Length:   275#015#012#015#012v=0#015#012o=- 3727693379 3727693380 IN IP4 192.168.1.35#015#012s=pjmedia#015#012b=AS:84#015#012t=0 0#015#012a=X-nat:0#015#012m=audio 4002 RTP/AVP 98 96#01
5#012c=IN IP4 192.168.1.35#015#012b=TIAS:64000#015#012a=rtcp:4003 IN IP4 192.168.1.35#015#012a=sendrecv#015#012a=rtpmap:98 speex/16000#015#012a=rtpmap:96 telephone-event/8000#015#012a=fmtp:96 0-16
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:305]: update_totag_set(): DEBUG: update_totag_set: totag retransmission
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2208]: tcpconn_send_put(): found fd in cache (12, 0x7fa00bf44ae0, 5)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf44ae0 n=1032 fd=12
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012SIP/2.0 200 OK#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;rport=33335;received=3
7.29.170.95;branch=z9hG4bKPjd8e1dc7c-4dd1-42ac-88e4-b09e0cc55a63;alias#015#012Record-Route: <sip:146.185.142.19:9773;transport=tcp;lr>#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012Fr
om: <sip:+34639446862@146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: <sip:+3412345678910@146.185.142.19>;tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21647 INVITE#015#
012Contact: <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>#015#012Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS#015#012Supported: replac
es, 100rel, timer, norefersub#015#012Session-Expires: 1800;refresher=uac#015#012Require: timer#015#012Content-Type: application/sdp#015#012Content-Length:   275#015#012#015#012v=0#015#012o=- 372769
3379 3727693380 IN IP4 192.168.1.35#015#012s=pjmedia#015#012b=AS:84#015#012t=0 0#015#012a=X-nat:0#015#012m=audio 4002 RTP/AVP 98 96#015#012c=IN IP4 192.168.1.35#015#012b=TIAS:64000#015#012a=rtcp:40
03 IN IP4 192.168.1.35#015#012a=sendrecv#015#012a=rtpmap:98 speex/16000#015#012a=rtpmap:96 telephone-event/8000#015#012a=fmtp:96 0-16
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=0
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP Request:
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:608]: parse_msg():  method:  <ACK>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  uri:     <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  version: <SIP/2.0>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj65ee4cd6-1345-4e0a-ba78-07849b77ab0e>
; state=6
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:177]: receive_msg(): preparing to run routing scripts...
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: sl [sl_funcs.c:388]: sl_filter_ACK(): DEBUG : sl_filter_ACK: to late to be a local ACK!
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=466 a=5 n=route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=574 a=25 n=mf_process_maxfwd_header
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=25 n=is_method
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=588 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=26 n=sanity_check
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [76]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [sip:+3412345678910@146.185.142.19]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21647> <ACK>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=469 a=5 n=route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=764 a=55 n=force_rport
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=765 a=25 n=nat_uac_test
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:158]: check_via_address(): (37.29.170.95, 37.29.170.95, 0)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=2 n=return
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=472 a=25 n=is_method
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=5 n=route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=592 a=24 n=has_totag
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=614 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=24 n=loose_route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:88]: is_preloaded(): is_preloaded: No
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:782]: after_loose(): Topmost route URI: 'sip:146.185.142.19:9773;transport=tcp;lr' is me
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:179]: find_next_route(): No next Route HF found
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:807]: after_loose(): No next URI found
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=597 a=5 n=route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=817 a=24 n=isdsturiset
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=818 a=24 n=handle_ruri_alias
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: nathelper [nathelper.c:1261]: handle_ruri_alias_f(): no alias param
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=2 n=return
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=598 a=25 n=is_method
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=602 a=25 n=is_method
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=604 a=5 n=route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=789 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=24 n=has_totag
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=788 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=785 a=25 n=check_route_param
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:985]: check_route_param(): params are <;transport=tcp;lr>
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=5 n=route
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=534 a=25 n=is_method
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=25 n=is_method
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=25 n=is_method
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=16 n=if
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=24 n=t_relay
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=12 , global msg id=11 , T on entrance=(nil)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=7756, isACK=1
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_funcs.c:279]: t_relay_to(): SER: forwarding ACK  statelessly
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: 0c9c2ef949368b5bf49c058f04a754ca
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:2843]: create_via_hf(): id added: <;i=5>, rcv proto=2
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:556]: forward_request(): Sending:#012ACK sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob SIP/2.0#015#012Via:
 SIP/2.0/TCP 146.185.142.19:9773;branch=z9hG4bKc4e1.0c9c2ef949368b5bf49c058f04a754ca.0;i=5#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;received=37.29.170.95;rport=33335;branch=z9hG4bKPj65ee4cd6-1345
-4e0a-ba78-07849b77ab0e;alias#015#012Max-Forwards: 69#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: sip:+3412345678910@146.185.142.19;tag=8abcc3d6
-6314-44e0-9fc7-748f455d00b2#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21647 ACK#015#012Content-Length:  0#015#012#015#012.
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:557]: forward_request(): orig. len=485, new_len=558, proto=2
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2208]: tcpconn_send_put(): found fd in cache (11, 0x7fa00bf40488, 6)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf40488 n=558 fd=11
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012ACK sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob SIP/2.0#015#012Via: S
IP/2.0/TCP 146.185.142.19:9773;branch=z9hG4bKc4e1.0c9c2ef949368b5bf49c058f04a754ca.0;i=5#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;received=37.29.170.95;rport=33335;branch=z9hG4bKPj65ee4cd6-1345-4
e0a-ba78-07849b77ab0e;alias#015#012Max-Forwards: 69#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: sip:+3412345678910@146.185.142.19;tag=8abcc3d6-6
314-44e0-9fc7-748f455d00b2#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21647 ACK#015#012Content-Length:  0
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:22:56 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:23:00 kamailio-alone /usr/sbin/kamailio[3094]: DEBUG: tm [h_table.c:126]: free_cell_helper(): freeing transaction 0x7fa00bf492c0 from timer.c:648
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP Request:
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:608]: parse_msg():  method:  <BYE>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  uri:     <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  version: <SIP/2.0>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj53d658e0-c4c1-4897-b515-dd62acfa5a9b>
; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:177]: receive_msg(): preparing to run routing scripts...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=466 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=574 a=25 n=mf_process_maxfwd_header
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=588 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=26 n=sanity_check
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [76]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [sip:+3412345678910@146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21648> <BYE>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=469 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=764 a=55 n=force_rport
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=765 a=25 n=nat_uac_test
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:158]: check_via_address(): (37.29.170.95, 37.29.170.95, 0)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=2 n=return
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=472 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=592 a=24 n=has_totag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=614 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=24 n=loose_route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:88]: is_preloaded(): is_preloaded: No
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:782]: after_loose(): Topmost route URI: 'sip:146.185.142.19:9773;transport=tcp;lr' is me
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:179]: find_next_route(): No next Route HF found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:807]: after_loose(): No next URI found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=597 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=817 a=24 n=isdsturiset
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=818 a=24 n=handle_ruri_alias
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: nathelper [nathelper.c:1261]: handle_ruri_alias_f(): no alias param
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=2 n=return
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=598 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=599 a=39 n=setflag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=600 a=39 n=setflag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=534 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=536 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=535 a=25 n=t_is_set
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=535 a=25 n=t_on_branch
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=24 n=t_relay
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=13 , global msg id=12 , T on entrance=(nil)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=7770, isACK=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 1, id 0 entered
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: 394dbdec3e45a97d62682f54a161512a
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=918 a=25 n=xdbg
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <script>: new branch [0] to sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=919 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=789 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=24 n=has_totag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=788 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=785 a=25 n=check_route_param
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:985]: check_route_param(): params are <;transport=tcp;lr>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:2843]: create_via_hf(): id added: <;i=5>, rcv proto=2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2208]: tcpconn_send_put(): found fd in cache (11, 0x7fa00bf40488, 6)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf40488 n=558 fd=11
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012BYE sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob SIP/2.0#015#012Via: S
IP/2.0/TCP 146.185.142.19:9773;branch=z9hG4bKa5e1.394dbdec3e45a97d62682f54a161512a.0;i=5#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;received=37.29.170.95;rport=33335;branch=z9hG4bKPj53d658e0-c4c1-4
897-b515-dd62acfa5a9b;alias#015#012Max-Forwards: 69#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: sip:+3412345678910@146.185.142.19;tag=8abcc3d6-6
314-44e0-9fc7-748f455d00b2#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21648 BYE#015#012Content-Length:  0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_funcs.c:362]: t_relay_to(): SER: new transaction fwd'ed
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=2 n=exit
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:616]: parse_msg(): SIP Reply  (status):
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:618]: parse_msg():  version: <SIP/2.0>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:620]: parse_msg():  status:  <200>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:622]: parse_msg():  reason:  <OK>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <146.185.142.19>; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKa5e1.394dbdec3e45a97d62682f54a161512a.0
>; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 236, <i> = <5>; state=16
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1011]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=9 T start=0xffffffffffffffff
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <33335>; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 234, <received> = <37.29.170.95>; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPj53d658e0-c4c1-4897-b515-dd62acfa5a9b>
; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=62
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:509]: parse_headers(): parse_headers: this is the second via
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [78]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [<sip:+3412345678910@146.185.142.19>]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21648> <BYE>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:888]: t_reply_matching(): DEBUG: t_reply_matching: hash 7770 label 0 branch 0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:943]: t_reply_matching(): DEBUG: t_reply_matching: reply matched (T=0x7fa00bf492c0)!
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 2, id 0 entered
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7fa00bf492c0) event type 2, reply code 200
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_lookup.c:1080]: t_check_msg(): DEBUG: t_check_msg: msg id=10 global id=10 T end=0x7fa00bf492c0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:2154]: reply_received(): DEBUG: reply_received: org. status uas=0, uac[0]=0 local=0 is_invite=0)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1232]: t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=200
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1750]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [msg_translator.c:2229]: generate_res_buf_from_sip_res(): old size: 516, new size: 396
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [msg_translator.c:2246]: generate_res_buf_from_sip_res(): copied size: orig:136, new: 16, rest: 380 msg=#012SIP/2.0 200 OK#015
#012Via: SIP/2.0/TCP 37.29.170.95:33335;rport=33335;received=37.29.170.95;branch=z9hG4bKPj53d658e0-c4c1-4897-b515-dd62acfa5a9b;alias#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012From
: <sip:+34639446862@146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: <sip:+3412345678910@146.185.142.19>;tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21648 BYE#015#012Co
ntent-Length:  0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [mem/shm_mem.c:101]: _shm_resize(): WARNING:vqm_resize: resize(0) called
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2208]: tcpconn_send_put(): found fd in cache (12, 0x7fa00bf44ae0, 5)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf44ae0 n=396 fd=12
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012SIP/2.0 200 OK#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;rport=33335;received=3
7.29.170.95;branch=z9hG4bKPj53d658e0-c4c1-4897-b515-dd62acfa5a9b;alias#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012From: <sip:+34639446862@146.185.142.19>;tag=d48d0318-ea78-44ed-90b
7-0634b2ee4f40#015#012To: <sip:+3412345678910@146.185.142.19>;tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21648 BYE#015#012Content-Length:  0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7fa00bf492c0, callback type 512, id 0 entered
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7fa00bf492c0) event type 512, reply code 200
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 1
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 3
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 4
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 5
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: tm [t_reply.c:1591]: cleanup_uac_timers(): DEBUG: cleanup_uac_timers: RETR/FR timers reset
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1339]: tcp_read_req(): content-length=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP Request:
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:608]: parse_msg():  method:  <BYE>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:610]: parse_msg():  uri:     <sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:612]: parse_msg():  version: <SIP/2.0>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjfefd5df3-8e04-49fe-a0d9-83a831218f67>
; state=6
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 237, <alias> = <n/a>; state=16
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:134]: receive_msg(): After parse_msg...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:177]: receive_msg(): preparing to run routing scripts...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=466 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=574 a=25 n=mf_process_maxfwd_header
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=579 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=588 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[REQINIT] c=[/etc/kamailio/kamailio.cfg] l=584 a=26 n=sanity_check
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [76]; uri=[sip:+3412345678910@146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:175]: get_hdr_field(): DEBUG: to body [sip:+3412345678910@146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <21649> <BYE>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:187]: get_hdr_field(): DEBUG: get_hdr_body : content_length=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:172]: parse_to_param(): DEBUG: add_param: tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=29
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=469 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=764 a=55 n=force_rport
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=765 a=25 n=nat_uac_test
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:158]: check_via_address(): (37.29.170.95, 37.29.170.95, 0)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[NATDETECT] c=[/etc/kamailio/kamailio.cfg] l=775 a=2 n=return
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=472 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DEFAULT_ROUTE] c=[/etc/kamailio/kamailio.cfg] l=480 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=592 a=24 n=has_totag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=614 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=596 a=24 n=loose_route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:88]: is_preloaded(): is_preloaded: No
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 12==14 && [88.15.197.56] == [146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 55288
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [forward.c:412]: check_self(): host != me
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:558]: grep_sock_info(): checking if host==us: 14==14 && [146.185.142.19] == [146.185.142.19]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [socket_info.c:565]: grep_sock_info(): checking if port 9773 (advertise 0) matches port 9773
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:782]: after_loose(): Topmost route URI: 'sip:146.185.142.19:9773;transport=tcp;lr' is me
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:179]: find_next_route(): No next Route HF found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:807]: after_loose(): No next URI found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=597 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=817 a=24 n=isdsturiset
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=818 a=24 n=handle_ruri_alias
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: nathelper [nathelper.c:1261]: handle_ruri_alias_f(): no alias param
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[DLGURI] c=[/etc/kamailio/kamailio.cfg] l=821 a=2 n=return
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=598 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=599 a=39 n=setflag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=600 a=39 n=setflag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[WITHINDLG] c=[/etc/kamailio/kamailio.cfg] l=610 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=534 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=536 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=535 a=25 n=t_is_set
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=535 a=25 n=t_on_branch
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=537 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=540 a=25 n=is_method
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=544 a=24 n=t_relay
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=14 , global msg id=13 , T on entrance=0xffffffffffffffff
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=7769, isACK=0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7fa00bf4d808, callback type 1, id 0 entered
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: 93ce403dfdc7700e8dc7cfa7395378b8
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=918 a=25 n=xdbg
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <script>: new branch [0] to sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[MANAGE_BRANCH] c=[/etc/kamailio/kamailio.cfg] l=919 a=5 n=route
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=783 a=24 n=is_request
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=789 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=784 a=24 n=has_totag
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: siputils [checks.c:100]: has_totag(): totag found
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=788 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=785 a=25 n=check_route_param
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: rr [loose.c:985]: check_route_param(): params are <;transport=tcp;lr>
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=795 a=16 n=if
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=41 n=isflagset
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=791 a=25 n=isbflagset
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:branch_route=[NATMANAGE] c=[/etc/kamailio/kamailio.cfg] l=792 a=2 n=return
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [msg_translator.c:2843]: create_via_hf(): id added: <;i=5>, rcv proto=2
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2208]: tcpconn_send_put(): found fd in cache (11, 0x7fa00bf40488, 6)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf40488 n=558 fd=11
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012BYE sip:+3412345678910@88.15.197.56:55288;transport=TCP;ob SIP/2.0#015#012Via: S
IP/2.0/TCP 146.185.142.19:9773;branch=z9hG4bK95e1.93ce403dfdc7700e8dc7cfa7395378b8.0;i=5#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;received=37.29.170.95;rport=33335;branch=z9hG4bKPjfefd5df3-8e04-4
9fe-a0d9-83a831218f67;alias#015#012Max-Forwards: 69#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: sip:+3412345678910@146.185.142.19;tag=8abcc3d6-6
314-44e0-9fc7-748f455d00b2#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21649 BYE#015#012Content-Length:  0
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: tm [t_funcs.c:362]: t_relay_to(): SER: new transaction fwd'ed
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: exec: *** cfgtrace:request_route=[RELAY] c=[/etc/kamailio/kamailio.cfg] l=547 a=2 n=exit
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: message repeated 5 times: [ DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil)]
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil)
Feb 15 14:23:01 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [receive.c:278]: receive_msg(): cleaning up
Feb 15 14:23:03 kamailio-alone /usr/sbin/kamailio[3100]: ERROR: <core> [tcp_read.c:274]: tcp_read_data(): error reading: Connection reset by peer (104) ([88.15.197.56]:55288 -> [88.15.197.56]:9773)
Feb 15 14:23:03 kamailio-alone /usr/sbin/kamailio[3100]: ERROR: <core> [tcp_read.c:1303]: tcp_read_req(): ERROR: tcp_read_req: error reading
Feb 15 14:23:03 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [io_wait.h:598]: io_watch_del(): DBG: io_watch_del (0xa81660, 9, -1, 0x10) fd_no=2 called
Feb 15 14:23:03 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_read.c:1460]: release_tcpconn(): releasing con 0x7fa00bf40488, state -2, fd=9, id=6 ([88.15.197.56]:55288 -> [88.15.197.5
6]:9773)
Feb 15 14:23:03 kamailio-alone /usr/sbin/kamailio[3100]: DEBUG: <core> [tcp_read.c:1464]: release_tcpconn(): extra_data (nil)
Feb 15 14:23:03 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3242]: handle_tcp_child(): reader response= 7fa00bf40488, -2 from 2
Feb 15 14:23:06 kamailio-alone /usr/sbin/kamailio[3094]: DEBUG: tm [h_table.c:126]: free_cell_helper(): freeing transaction 0x7fa00bf492c0 from timer.c:648
Feb 15 14:23:07 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [io_wait.h:598]: io_watch_del(): DBG: io_watch_del (0xa81660, 9, -1, 0x10) fd_no=2 called
Feb 15 14:23:07 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1460]: release_tcpconn(): releasing con 0x7fa00bf44ae0, state 1, fd=9, id=5 ([37.29.170.95]:33335 -> [37.29.170.95
]:9773)
Feb 15 14:23:07 kamailio-alone /usr/sbin/kamailio[3099]: DEBUG: <core> [tcp_read.c:1464]: release_tcpconn(): extra_data (nil)
Feb 15 14:23:07 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3242]: handle_tcp_child(): reader response= 7fa00bf44ae0, 1 from 1
Feb 15 14:23:07 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [io_wait.h:376]: io_watch_add(): DBG: io_watch_add(0xa28d40, 29, 2, 0x7fa00bf44ae0), fd_no=19
Feb 15 14:23:07 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3369]: handle_tcp_child(): CONN_RELEASE  0x7fa00bf44ae0 refcnt= 1
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: tm [t_reply.c:1232]: t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=408
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: tm [t_reply.c:1750]: relay_reply(): DEBUG: relay_reply: branch=0, save=0, relay=0 icode=0
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: <core> [mem/shm_mem.c:101]: _shm_resize(): WARNING:vqm_resize: resize(0) called
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: <core> [tcp_main.c:2211]: tcpconn_send_put(): tcp connection found (0x7fa00bf44ae0), acquiring fd
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: <core> [tcp_main.c:2221]: tcpconn_send_put(): c=0x7fa00bf44ae0, n=16
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3102]: DEBUG: <core> [tcp_main.c:3475]: handle_ser_child(): read response= 7fa00bf44ae0, 2, fd -1 from 5 (3093)
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: <core> [tcp_main.c:2251]: tcpconn_send_put(): after receive_fd: c= 0x7fa00bf44ae0 n=8 fd=5
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: <core> [tcp_main.c:2430]: tcpconn_do_send(): sending...
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: <core> [tcp_main.c:2464]: tcpconn_do_send(): after real write: c= 0x7fa00bf44ae0 n=445 fd=5
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: <core> [tcp_main.c:2465]: tcpconn_do_send(): buf=#012SIP/2.0 408 Request Timeout#015#012Via: SIP/2.0/TCP 37.29.170.95:33335;rport=333
35;branch=z9hG4bKPjfefd5df3-8e04-49fe-a0d9-83a831218f67;alias;received=37.29.170.95#015#012From: sip:+34639446862@146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To: sip:+34123456789
10@146.185.142.19;tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012Call-ID: 167f1514-e91c-42c7-8767-afc78c31abda#015#012CSeq: 21649 BYE#015#012Server: kamailio (4.3.4 (x86_64/linux))#015#012Content-
Length: 0
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: tm [t_hooks.c:266]: run_trans_callbacks_internal(): DBG: trans=0x7fa00bf4d808, callback type 512, id 0 entered
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: acc [acc_logic.c:643]: tmcb_func(): acc callback called for t(0x7fa00bf4d808) event type 512, reply code 408
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 0
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 1
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 2
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 3
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 4
Feb 15 14:23:31 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: acc [acc_extra.h:80]: free_strar_mem(): Freeing memory, type is 2, message_index 6, index i 5
Feb 15 14:23:36 kamailio-alone /usr/sbin/kamailio[3094]: DEBUG: tm [h_table.c:126]: free_cell_helper(): freeing transaction 0x7fa00bf4d808 from timer.c:648
Feb 15 14:24:14 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: usrloc [urecord.c:382]: wb_timer(): Binding '+34639446862','sip:+34639446862@88.15.197.56:40543;transport=TCP;ob' has expired
Feb 15 14:24:14 kamailio-alone /usr/sbin/kamailio[3093]: DEBUG: usrloc [ucontact.c:1787]: uldb_delete_attrs_ruid(): trying to delete location attributes


As you can see check_route_param(): params are <;transport=tcp;lr>

2018-02-15 18:16 GMT+01:00 Daniel-Constantin Mierla <miconda@gmail.com>:

Based on the logs, there is no  check_route_param() executed. Actually, it is an initial INVITE, doesn't have a to-tag, so there is no Route header added previously by kamailio where check_route_param() can work on.

Looking at the headers, this initial INVITE has Via and Contact with public addresses (maybe UA is using stun), only the SDP seems to have carrier grand nat address. You have to adjust the parameter for nat_uac_test() in order to detect it is a natted call.

Cheers,
Daniel


On 15.02.18 15:35, Pau Giralt wrote:
My kamailio version is:

version: kamailio 4.4.6 (x86_64/linux) becbde
flags: STATS: Off, USE_TCP, USE_TLS, USE_SCTP, TLS_HOOKS, DISABLE_NAGLE, USE_MCAST, DNS_IP_HACK, SHM_MEM, SHM_MMAP, PKG_MALLOC, Q_MALLOC, F_MALLOC, TLSF_MALLOC, DBG_SR_MEMORY, USE_FUTEX, FAST_LOCK-ADAPTIVE_WAIT, USE_DNS_CACHE, USE_DNS_FAILOVER, USE_NAPTR, USE_DST_BLACKLIST, HAVE_RESOLV_RES
ADAPTIVE_WAIT_LOOPS=1024, MAX_RECV_BUFFER_SIZE 262144, MAX_LISTEN 16, MAX_URI_SIZE 1024, BUF_SIZE 65535, DEFAULT PKG_SIZE 8MB
poll method support: poll, epoll_lt, epoll_et, sigio_rt, select.
id: becbde
compiled on 08:18:45 Jul  3 2017 with gcc 5.4.0


I've pasted the logs below.
 
( ... )
[...]


Thanks!


2018-02-15 15:02 GMT+01:00 Daniel-Constantin Mierla <miconda@gmail.com>:

Hello,

first, what is the version of kamailio?

Then, can you load debugger module and set cfgtrace=1, then send here all log messages for a case exposing this issue? It should show what actions are executed from config.

Cheers,
Daniel


On 15.02.18 12:08, Pau Giralt wrote:

Hi!

I'm working with kamailio and rtpproxy.
When I configure the clients to send sip messages through TCP adding the ";transport=tcp" in the sip message the rtpproxy is not working anymore.

The code is never passing the point pasted below, inside route[NATMANAGE] in kamailio.cfg

if (!(isflagset(FLT_NATS) || isbflagset(FLB_NATB))) return;

Therefore, rtpproxy_manage("co"); is never reached.

Could it be a parsing problem? ( check_route_param("nat=yes") )

The config file is exactly the same as the one provided in the kamailio repository (the default one)

Thanks!




_______________________________________________
Kamailio (SER) - Users Mailing List
sr-users@lists.kamailio.org
https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users

-- 
Daniel-Constantin Mierla
www.twitter.com/miconda -- www.linkedin.com/in/miconda
Kamailio Advanced Training - March 5-7, 2018, Berlin - www.asipto.com
Kamailio World Conference - May 14-16, 2018 - www.kamailioworld.com


-- 
Daniel-Constantin Mierla
www.twitter.com/miconda -- www.linkedin.com/in/miconda
Kamailio Advanced Training - March 5-7, 2018, Berlin - www.asipto.com
Kamailio World Conference - May 14-16, 2018 - www.kamailioworld.com