Hi, Daniel. I just done one more test topos with re-invite which comes from caller to callee, same direction as PRACK.
And I found that, in case of prack, b_contact field is empty... Please find attached debug=3 part of re-invite message. Hope it helps. -- Best regards, Sergey Basov e-mail: [email protected] 2017-04-27 10:30 GMT+03:00 Sergey Basov <[email protected]>: > Hi, Daniel > > Please look at attached part of debug=3 while receiving and parsing PRACK. > At line 208 seems rr module does not find correct part of record_route > which in DB consists from 2 parts. > > So at line 219 and later uac module cannot restore uris. > > Thank you. > -- > Best regards, > Sergey Basov e-mail: [email protected] > > > 2017-04-26 17:08 GMT+03:00 Sergey Basov <[email protected]>: >> Thanks for workaround. >> >> But I will wait for you solution ) >> >> I ready for testing ) >> >> Thank you Daniel for your work! >> >> -- >> Best regards, >> Sergey Basov e-mail: [email protected] >> >> >> 2017-04-26 16:57 GMT+03:00 Daniel-Constantin Mierla <[email protected]>: >>> Hello, >>> >>> >>> On 26.04.17 14:53, Sergey Basov wrote: >>>> Hi All. >>>> >>>> I have just try to test topos with GW which requires PRACK. >>>> >>>> As you can see UA at packet 21 send PRACK to topos contact, but after >>>> topos, on other kamailio side in PRACK request line present not >>>> kontact but record-route header. >>>> >>>> Can you fix it? >>>> >>>> >>> probably needs to look into the code. If you need a quick workaround, >>> try to remove Supported header from INVITE so the callee should no >>> longer Require 100rel. >>> >>> Cheers, >>> Daniel >>> >>> -- >>> Daniel-Constantin Mierla >>> www.twitter.com/miconda -- www.linkedin.com/in/miconda >>> Kamailio Advanced Training - May 22-24 (USA) - www.asipto.com >>> Kamailio World Conference - May 8-10, 2017 - www.kamailioworld.com >>> >>> >>> _______________________________________________ >>> Kamailio (SER) - Users Mailing List >>> [email protected] >>> https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users
Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:595]: parse_msg(): SIP Request: Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:597]: parse_msg(): method: <INVITE> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:599]: parse_msg(): uri: <sip:[email protected]:5061;transport=tls> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:601]: parse_msg(): version: <SIP/2.0> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK-524287-1---c29d5f106e7a4975>; state=6 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:486]: parse_headers(): Via found, flags=2 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:488]: parse_headers(): this is the first via Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:171]: parse_to_param(): DEBUG: add_param: tag=10000005923062 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:871]: parse_addr_spec(): end of header reached, state=29 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:171]: get_hdr_field(): <To> [73]; uri=[sip:[email protected]:5061;transport=TLS] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:[email protected]:5061;transport=TLS>] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <3> <INVITE> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:183]: get_hdr_field(): content_length=305 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:171]: parse_to_param(): DEBUG: add_param: tag=2953e855 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:871]: parse_addr_spec(): end of header reached, state=29 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: topos [tps_msg.c:725]: tps_request_received(): handling incoming request Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: topos [tps_msg.c:371]: tps_pack_message(): compacted headers - x_via1: [SIP/2.0/TLS 100.80.183.29:5061;branch=z9hG4bK-524287-1---c29d5f106e7a4975;rport](79) - x_via2: [](0) - x_vbranch1: [z9hG4bK-524287-1---c29d5f106e7a4975](35) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: topos [tps_msg.c:473]: tps_pack_message(): compacted headers - a_rr: [](0) - b_rr: [](0) - s_rr: [](0) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: topos [tps_msg.c:476]: tps_pack_message(): compacted headers - as_contact: [](0) - bs_contact: [](0) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: topos [tps_storage.c:120]: tps_storage_lock_get(): tps lock get: 334 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:116]: db_new_result(): allocate 56 bytes for result set at 0x7f5350b8ea98 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:66]: db_mysql_get_columns(): 21 columns returned from the query Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:154]: db_allocate_columns(): allocate 168 bytes for result names at 0x7f5350bcb3b0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:165]: db_allocate_columns(): allocate 84 bytes for result types at 0x7f5350b925f0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[0] at 0x7f53508b1c18 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508b1c18)[0]=[rectime] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:115]: db_mysql_get_columns(): use DB1_DATETIME result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[1] at 0x7f53508b2a60 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508b2a60)[1]=[a_callid] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[2] at 0x7f5350b23588 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5350b23588)[2]=[a_uuid] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[3] at 0x7f53508affc0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508affc0)[3]=[b_uuid] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[4] at 0x7f5350b23a10 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5350b23a10)[4]=[a_contact] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[5] at 0x7f53508adab0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508adab0)[5]=[b_contact] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[6] at 0x7f53508b1708 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508b1708)[6]=[as_contact] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[7] at 0x7f53508ae120 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508ae120)[7]=[bs_contact] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[8] at 0x7f53508afa18 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508afa18)[8]=[a_tag] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[9] at 0x7f53508aee00 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508aee00)[9]=[b_tag] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[10] at 0x7f5350b21608 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5350b21608)[10]=[a_rr] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:120]: db_mysql_get_columns(): use DB1_BLOB result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[11] at 0x7f53508ad448 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508ad448)[11]=[b_rr] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:120]: db_mysql_get_columns(): use DB1_BLOB result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[12] at 0x7f5350b229d8 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5350b229d8)[12]=[s_rr] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:120]: db_mysql_get_columns(): use DB1_BLOB result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[13] at 0x7f53508b0640 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508b0640)[13]=[iflags] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:99]: db_mysql_get_columns(): use DB1_INT result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[14] at 0x7f53508af470 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508af470)[14]=[a_uri] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[15] at 0x7f53508ae790 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508ae790)[15]=[b_uri] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[16] at 0x7f53508b2638 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508b2638)[16]=[r_uri] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[17] at 0x7f53508b2128 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508b2128)[17]=[a_srcaddr] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[18] at 0x7f53508b11f8 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f53508b11f8)[18]=[b_srcaddr] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[19] at 0x7f5350b8ec78 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5350b8ec78)[19]=[s_method] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:84]: db_mysql_get_columns(): allocate 16 bytes for RES_NAMES[20] at 0x7f5350bcb160 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:91]: db_mysql_get_columns(): RES_NAMES(0x7f5350bcb160)[20]=[s_cseq] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: db_mysql [km_res.c:135]: db_mysql_get_columns(): use DB1_STRING result type Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:184]: db_allocate_rows(): allocate 16 bytes for rows at 0x7f5350bcaee8 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_row.c:117]: db_allocate_row(): allocate 672 bytes for row values at 0x7f5350aeb0a0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:158]: db_str2val(): converting DATETIME [2017-04-27 12:13:52] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [xMPIakb6Hm2d64XzzmkKwg..] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [atpsh-5901aaef-2aa8-3] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [btpsh-5901aaef-2aa8-3] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:[email protected]:29300;transport=tls] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [sip:KITS1.MSS.LIFE.COM:5060;transport=UDP] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [<sip:[email protected]:5061;transport=tls>] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [<sip:[email protected]>] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [2953e855] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [10000005923062] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:169]: db_str2val(): converting BLOB [] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:169]: db_str2val(): converting BLOB [<sip:KITS1.MSS.LIFE.COM:5060;transport=UDP;lr>] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:169]: db_str2val(): converting BLOB [<sip:10.56.42.33;r2=on;lr;ftag=2953e855;did=d9.e631;vsf=AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-;vst=AAAAAAMOAwEABwcEAwd3AnAcBAQAAwsAAAYKGwIDAwFAQ1NDBgQaDgAWcG9ydD1UTFM-;nat=yes>,<sip:212.58.160.253:5061;transport=tls;r2=on;lr;ftag=2953e855;did=d9.e631;vsf=AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-;vst=AAAAAAMOAwEABwcEAwd3AnAcBAQAAwsAAAYKGwIDAwFAQ1NDBgQaDgAWcG9ydD1UTFM-;nat=yes>] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:74]: db_str2val(): converting INT [2] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [INVITE] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_val.c:118]: db_str2val(): converting STRING [2] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:79]: db_free_columns(): freeing 21 columns Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[0] at 0x7f53508b1c18 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[1] at 0x7f53508b2a60 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[2] at 0x7f5350b23588 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[3] at 0x7f53508affc0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[4] at 0x7f5350b23a10 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[5] at 0x7f53508adab0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[6] at 0x7f53508b1708 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[7] at 0x7f53508ae120 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[8] at 0x7f53508afa18 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[9] at 0x7f53508aee00 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[10] at 0x7f5350b21608 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[11] at 0x7f53508ad448 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[12] at 0x7f5350b229d8 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[13] at 0x7f53508b0640 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[14] at 0x7f53508af470 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[15] at 0x7f53508ae790 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[16] at 0x7f53508b2638 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[17] at 0x7f53508b2128 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[18] at 0x7f53508b11f8 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[19] at 0x7f5350b8ec78 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:83]: db_free_columns(): freeing RES_NAMES[20] at 0x7f5350bcb160 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:92]: db_free_columns(): freeing result names at 0x7f5350bcb3b0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:97]: db_free_columns(): freeing result types at 0x7f5350b925f0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:52]: db_free_rows(): freeing 1 rows Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_row.c:95]: db_free_row(): freeing row values at 0x7f5350aeb0a0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:60]: db_free_rows(): freeing rows at 0x7f5350bcaee8 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [db_res.c:134]: db_free_result(): freeing result set at 0x7f5350b8ea98 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: topos [tps_storage.c:132]: tps_storage_lock_release(): tps lock release: 334 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:595]: parse_msg(): SIP Request: Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:597]: parse_msg(): method: <INVITE> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:599]: parse_msg(): uri: <sip:KITS1.MSS.LIFE.COM:5060;transport=UDP> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:601]: parse_msg(): version: <SIP/2.0> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK-524287-1---c29d5f106e7a4975>; state=6 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=17 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:486]: parse_headers(): Via found, flags=2 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:488]: parse_headers(): this is the first via Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [receive.c:178]: receive_msg(): After parse_msg... Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [receive.c:221]: receive_msg(): preparing to run routing scripts... Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [select.c:412]: run_select(): Calling SELECT 0x7f53508ebed0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: maxfwd [mf_funcs.c:85]: is_maxfwd_present(): value = 70 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:171]: parse_to_param(): DEBUG: add_param: tag=10000005923062 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:871]: parse_addr_spec(): end of header reached, state=29 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:171]: get_hdr_field(): <To> [73]; uri=[sip:[email protected]:5061;transport=TLS] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:172]: get_hdr_field(): to body [<sip:[email protected]:5061;transport=TLS>] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <3> <INVITE> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:183]: get_hdr_field(): content_length=305 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/msg_parser.c:89]: get_hdr_field(): found end of header Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:171]: parse_to_param(): DEBUG: add_param: tag=2953e855 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [parser/parse_addr_spec.c:871]: parse_addr_spec(): end of header reached, state=29 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: sanity [mod_sanity.c:248]: w_sanity_check(): sanity checks result: 1 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: INFO: <script>: NATDETECT entered Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: siputils [checks.c:100]: has_totag(): totag found Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [loose.c:89]: is_preloaded(): is_preloaded: No Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 5060) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): checking advertise if host==us: 18==14 && [KITS1.MSS.LIFE.COM] == [212.58.162.215] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5070 (advertise 5070) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.42.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.42.37] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==10 && [KITS1.MSS.LIFE.COM] == [10.1.23.30] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.42.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==10 && [KITS1.MSS.LIFE.COM] == [10.1.23.30] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5161 (advertise 0) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5061 (advertise 5061) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5071 (advertise 0) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5081 (advertise 5071) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.41.30] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5061 (advertise 5061) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 18==11 && [KITS1.MSS.LIFE.COM] == [10.56.41.30] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5081 (advertise 5081) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [forward.c:412]: check_self(): host != me Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==11 && [212.58.160.253] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 5060) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==11 && [212.58.160.253] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5070 (advertise 5070) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==11 && [212.58.160.253] == [10.56.42.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==11 && [212.58.160.253] == [10.56.42.37] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==10 && [212.58.160.253] == [10.1.23.30] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==11 && [212.58.160.253] == [10.56.42.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==10 && [212.58.160.253] == [10.1.23.30] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5161 (advertise 0) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 14==11 && [212.58.160.253] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5061 (advertise 5061) matches port 5061 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): checking advertise if host==us: 14==14 && [212.58.160.253] == [212.58.160.253] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [loose.c:788]: after_loose(): Topmost route URI: 'sip:212.58.160.253:5061;transport=tls;r2=on;lr;ftag=2953e855;did=d9.e631;vsf=AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-;vst=AAAAAAMOAwEABwcEAwd3AnAcBAQAAwsAAAYKGwIDAwFAQ1NDBgQaDgAWcG9ydD1UTFM-;nat=yes' is me Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 11==11 && [10.56.42.33] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 5060) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:583]: grep_sock_info(): checking advertise if host==us: 11==14 && [10.56.42.33] == [212.58.162.215] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 11==11 && [10.56.42.33] == [10.56.41.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5070 (advertise 5070) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:564]: grep_sock_info(): checking if host==us: 11==11 && [10.56.42.33] == [10.56.42.33] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [socket_info.c:567]: grep_sock_info(): checking if port 5060 (advertise 0) matches port 5060 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [loose.c:884]: after_loose(): URI to be processed: 'sip:KITS1.MSS.LIFE.COM:5060;transport=UDP;lr' Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [loose.c:893]: after_loose(): Next URI is a loose router Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [rr_cb.c:95]: run_rr_callbacks(): callback id 1 entered with <transport=tls;r2=on;lr;ftag=2953e855;did=d9.e631;vsf=AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-;vst=AAAAAAMOAwEABwcEAwd3AnAcBAQAAwsAAAYKGwIDAwFAQ1NDBgQaDgAWcG9ydD1UTFM-;nat=yes> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_handlers.c:1209]: dlg_onroute(): route param is 'd9.e631' (len=7) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:690]: dlg_lookup(): ref dlg 0x7f530e925af0 with 1 -> 3 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:692]: dlg_lookup(): dialog id=4974 found on entry 157 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_profile.c:530]: set_current_dialog(): setting current dialog [157:4974] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:1122]: next_state_dlg(): dialog 0x7f530e925af0 changed from state 4 to state 4, due event 8 (ref 3) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_timer.c:110]: insert_dialog_timer_unsafe(): inserting 0x7f530e925b50 for 118797440 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:634]: dlg_update_contact(): same contact for leg[0] - [sip:[email protected]:29300;transport=tls] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:605]: dlg_update_cseq(): cseq of leg[0] is 3 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_handlers.c:1411]: dlg_onroute(): sequential request successfully processed Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [record.c:918]: add_rr_param(): rr_param_buf=<;did=d9.e631> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:922]: dlg_unref_helper(): unref op on 0x7f530e925af0 with 1 from dlg_hash.c:940 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:926]: dlg_unref_helper(): unref dlg 0x7f530e925af0 with 1 -> 2 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [rr_cb.c:95]: run_rr_callbacks(): callback id 0 entered with <transport=tls;r2=on;lr;ftag=2953e855;did=d9.e631;vsf=AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-;vst=AAAAAAMOAwEABwcEAwd3AnAcBAQAAwsAAAYKGwIDAwFAQ1NDBgQaDgAWcG9ydD1UTFM-;nat=yes> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: uac [replace.c:535]: restore_uri(): getting 'vsf' Route param Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: uac [replace.c:543]: restore_uri(): route param is 'AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-' (len=68) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [record.c:918]: add_rr_param(): rr_param_buf=<;did=d9.e631;vsf=AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: uac [replace.c:645]: restore_uri(): decoded uris are: new=[sip:[email protected]:5060;user=phone] old=[sip:[email protected]:5061;transport=TLS] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: uac [replace.c:535]: restore_uri(): getting 'vst' Route param Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: uac [replace.c:543]: restore_uri(): route param is 'AAAAAAMOAwEABwcEAwd3AnAcBAQAAwsAAAYKGwIDAwFAQ1NDBgQaDgAWcG9ydD1UTFM-' (len=68) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: rr [record.c:918]: add_rr_param(): rr_param_buf=<;did=d9.e631;vsf=AAAAAAoLAQ4DAA4DAHlnYg5heGIAeXFodBhzYX8PBgoDAA1ESBEAXB4bHwEXdD1UTFM-;vst=AAAAAAMOAwEABwcEAwd3AnAcBAQAAwsAAAYKGwIDAwFAQ1NDBgQaDgAWcG9ydD1UTFM-> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: uac [replace.c:645]: restore_uri(): decoded uris are: new=[sip:[email protected]:5060;user=phone] old=[sip:[email protected]:5061;transport=TLS] Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: INFO: <script>: INVITE is forwarded statelessy Remove add Route Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: INFO: <script>: Withindlg RELAY sip:KITS1.MSS.LIFE.COM:5060;transport=UDP Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: INFO: <script>: route RELAY entered 10.56.41.33:5061 212.58.160.253 fs=udp:10.56.42.33:5060 sndip=<null> Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: tm [t_lookup.c:1312]: t_newtran(): DEBUG: t_newtran: msg id=52 , global msg id=51 , T on entrance=(nil) Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: tm [t_lookup.c:466]: t_lookup_request(): t_lookup_request: start searching: hash=57554, isACK=0 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: tm [t_lookup.c:424]: matching_3261(): DEBUG: RFC3261 transaction matching failed Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: tm [t_lookup.c:648]: t_lookup_request(): DEBUG: t_lookup_request: no transaction found Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7f530e92a3b8, callback type 1, id 0 entered Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: siptrace [siptrace.c:1114]: trace_onreq_in(): trace off... Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7f530e92a3b8, callback type 1, id 0 entered Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:690]: dlg_lookup(): ref dlg 0x7f530e925af0 with 1 -> 3 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:692]: dlg_lookup(): dialog id=4974 found on entry 157 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_handlers.c:727]: dlg_onreq(): dialog added to tm callbacks Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:922]: dlg_unref_helper(): unref op on 0x7f530e925af0 with 1 from dlg_hash.c:940 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: dialog [dlg_hash.c:926]: dlg_unref_helper(): unref dlg 0x7f530e925af0 with 1 -> 2 Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: tm [t_hooks.c:358]: run_reqin_callbacks_internal(): DBG: trans=0x7f530e92a3b8, callback type 1, id 0 entered Apr 27 12:14:35 csbc-uat /usr/sbin/kamailio[10920]: DEBUG: <core> [md5utils.c:67]: MD5StringArray(): MD5 calculated: 80f549253bc2b97c790a13ee3d0157a4
_______________________________________________ Kamailio (SER) - Users Mailing List [email protected] https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users
