[SR-Users] Problem with "transport=tcp" and rtpproxy

Fri Feb 16 10:45:23 CET 2018

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 at 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 at 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 at 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 at 146.185.142.19
;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#
012To: sip:+3412345678910 at 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 at 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 at 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 at 146.185.142.19
;tag=d48d0318-ea78-44ed-90b7-0634b
2ee4f40#015#012To: sip:+3412345678910 at 146.185.142.19#015#012Contact:
<sip:+34639446862 at 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 at 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 at 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 at 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 at 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 at 146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
<sip:+3412345678910 at 146.185.142.19>;tag=8abc
c3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21647 INVITE#015#012Contact:
<sip:+3412345678910 at 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 at 146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
<sip:+3412345678910 at 146.185.142.19>;tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq:
21647 IN
VITE#015#012Contact:
<sip:+3412345678910 at 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 at 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 at 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 at 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 at 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 at 146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
sip:+3412345678910 at 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 at 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 at 146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
sip:+3412345678910 at 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 at 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 at 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 at 146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
<sip:+3412345678910 at 146.185.142.19>;tag=8abc
c3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq: 21647 INVITE#015#012Contact:
<sip:+3412345678910 at 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 at 146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
<sip:+3412345678910 at 146.185.142.19>;tag=8abcc3d6-6314-44e0-9fc7-748f455d00b2#015#012CSeq:
21647 INVITE#015#
012Contact: <sip:+3412345678910 at 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 at 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 at 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 at 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 at 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 at 146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
sip:+3412345678910 at 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 at 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 at 146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
sip:+3412345678910 at 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 at 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 at 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 at 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 at 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 at 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 at 146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
sip:+3412345678910 at 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 at 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 at 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 at 146.185.142.19>;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
<sip:+3412345678910 at 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 at 146.185.142.19>;tag=d48d0318-ea78-44ed-90b
7-0634b2ee4f40#015#012To:
<sip:+3412345678910 at 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 at 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 at 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 at 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 at 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 at 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 at 146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
sip:+3412345678910 at 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 at 146.185.142.19;tag=d48d0318-ea78-44ed-90b7-0634b2ee4f40#015#012To:
sip:+34123456789
10 at 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 at 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 at 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 at 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 Listsr-users at lists.kamailio.orghttps://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users
>>
>>
>> --
>> Daniel-Constantin Mierlawww.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 Mierlawww.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
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.kamailio.org/pipermail/sr-users/attachments/20180216/84ca3661/attachment.html>