11 Dec
2013
11 Dec
'13
11:57 a.m.
hello,
I’m trying to build two kamailio-3.3.4 server like this:
ua1 ----> kamailio1(k1)-----> kamailio2(k2) -----> ua2
ua1 (5978003 ) is register k1
ua2 (5001005) is register k2
When ua1 call to ua2 sip process through k1 and k2
The problem is k2 server ACK not transfer to ua2 and k2 has received
ack signals from u1 through k1
I ngrep sip process for k2 and k2 /var/log/debug , see the problem is
1.
First ACK uri have ua2 number sip:5001005@xxx.xxx.xxx.xxx(k2):5003;ob
, is correct !!
2. Second ack not include 5001005 , again loop itself ; Route:
<sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>
loose_route Next hop: 'sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941'
is loose router is ,
so next hop Not found in usrloc db 5001005 user and not transfer to ua2
How to fix this problem, any suggestions?
=================================
/var/log/debug in k2 server :
: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request:
: DEBUG: <core> [parser/msg_parser.c:626]: method: <ACK>
: DEBUG: <core> [parser/msg_parser.c:628]: uri:
<sip:5001005@xxx.xxx.xxx.xxx(k2):5003;ob>
: DEBUG: <core> [parser/msg_parser.c:630]: version: <SIP/2.0>
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232,
<branch> = <z9hG4bKcydzigwkX>; state=16
: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5
: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2
: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via
: DEBUG: <core> [receive.c:149]: After parse_msg...
: DEBUG: <core> [receive.c:190]: preparing to run routing scripts...
: DEBUG: sl [sl_funcs.c:396]: DEBUG : sl_filter_ACK: to late to be a local ACK!
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 234,
<received> = <122.116.37.55>; state=6
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232,
<branch> = <z9hG4bK-d8754z-5479c6361610102b-1---d8754z->; state=6
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 235,
<rport> = <60496>; state=16
: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5
: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=10
: DEBUG: <core> [parser/msg_parser.c:524]: parse_headers: this is the second via
: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param:
tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf
: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29
: DEBUG: <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To>
[73]; uri=[sip:5001005@xxx.xxx.xxx.xxx(k2)]
: DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: to body
["5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2)>]
: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=1944d063
: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29
: DEBUG: siptrace [siptrace.c:794]: storing info...
: DEBUG: maxfwd [mf_funcs.c:85]: value = 69
: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=42 global
id=41 T start=0xffffffffffffffff
: DEBUG: <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>:
<1> <ACK>
: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body :
content_length=0
: DEBUG: <core> [parser/msg_parser.c:104]: found end of header
: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching:
hash=41886, isACK=1
: DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed
: DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found
: DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=42 global
id=42 T end=(nil)
: DEBUG: rr [loose.c:88]: is_preloaded: No
: DEBUG: <core> [socket_info.c:583]: grep_sock_info - checking if
host==us: 11==11 && [xxx.xxx.xxx.xxx(k2)] == [xxx.xxx.xxx.xxx(k2)]
: DEBUG: <core> [socket_info.c:587]: grep_sock_info - checking if port
5003 (advertise 0) matches port 5003
: DEBUG: rr [loose.c:597]: Next hop:
'sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941' is loose router
: DEBUG: rr [loose.c:647]: The last route URI:
'sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941'
: DEBUG: rr [rr_cb.c:97]: callback id 0 entered with <ob>
: DEBUG: dialog [dlg_handlers.c:1109]: Route param 'did' not found
: DEBUG: tm [t_lookup.c:1379]: DEBUG: t_newtran: msg id=42 , global
msg id=42 , T on entrance=(nil)
: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching:
hash=41886, isACK=1
: DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed
: DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found
: DEBUG: tm [t_funcs.c:315]: SER: forwarding ACK statelessly
: DEBUG: <core> [msg_translator.c:206]:
check_via_address(xxx.xxx.xxx.xxx(k1), xxx.xxx.xxx.xxx(k1), 0)
: DEBUG: <core> [forward.c:609]: Sending:#012ACK
sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941
SIP/2.0#015#012Record-Route:
<sip:xxx.xxx.xxx.xxx(k2):5003;lr=on>#015#012Record-Route:
<sip:xxx.xxx.xxx.xxx(k1):5002;lr=on>#015#012Via: SIP/2.0/UDP
xxx.xxx.xxx.xxx(k2):5003;branch=z9hG4bKcydzigwkX#015#012Via:
SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKcydzigwkX#015#012Via:
SIP/2.0/UDP
100.65.104.101:60496;received=122.116.37.55;branch=z9hG4bK-d8754z-5479c6361610102b-1---d8754z-;rport=60496#015#012Max-Forwards:
68#015#012Contact:
<sip:5978003@122.116.37.55:60496;transport=udp>#015#012To:
"5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf#015#012From:
"5978003"<sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063#015#012Call-ID:
NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI.#015#012CSeq: 1
ACK#015#012User-Agent: eyeBeam release 1100z stamp
47739#015#012Content-Length: 0#015#012#015#012.
: DEBUG: <core> [forward.c:611]: orig. len=669, new_len=730, proto=1
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up
: DEBUG: <core> [parser/msg_parser.c:624]: SIP Request:
: DEBUG: <core> [parser/msg_parser.c:626]: method: <ACK>
: DEBUG: <core> [parser/msg_parser.c:628]: uri:
<sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>
: DEBUG: <core> [parser/msg_parser.c:630]: version: <SIP/2.0>
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232,
<branch> = <z9hG4bKcydzigwkX>; state=16
: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5
: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=2
: DEBUG: <core> [parser/msg_parser.c:513]: parse_headers: this is the first via
: DEBUG: <core> [receive.c:149]: After parse_msg...
: DEBUG: <core> [receive.c:190]: preparing to run routing scripts...
: DEBUG: sl [sl_funcs.c:396]: DEBUG : sl_filter_ACK: to late to be a local ACK!
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232,
<branch> = <z9hG4bKcydzigwkX>; state=16
: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5
: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=10
: DEBUG: <core> [parser/msg_parser.c:524]: parse_headers: this is the second via
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 234,
<received> = <122.116.37.55>; state=6
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 232,
<branch> = <z9hG4bK-d8754z-5479c6361610102b-1---d8754z->; state=6
: DEBUG: <core> [parser/parse_via.c:1286]: Found param type 235,
<rport> = <60496>; state=16
: DEBUG: <core> [parser/parse_via.c:2561]: end of header reached, state=5
: DEBUG: <core> [parser/msg_parser.c:511]: parse_headers: Via found, flags=10
: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param:
tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf
: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29
: DEBUG: <core> [parser/msg_parser.c:188]: DEBUG: get_hdr_field: <To>
[73]; uri=[sip:5001005@xxx.xxx.xxx.xxx(k2)]
: DEBUG: <core> [parser/msg_parser.c:190]: DEBUG: to body
["5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2)>]
: DEBUG: <core> [parser/parse_to.c:178]: DEBUG: add_param: tag=1944d063
: DEBUG: <core> [parser/parse_to.c:802]: end of header reached, state=29
: DEBUG: siptrace [siptrace.c:794]: storing info...
: DEBUG: maxfwd [mf_funcs.c:85]: value = 68
: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=43 global
id=42 T start=(nil)
: DEBUG: <core> [parser/msg_parser.c:168]: get_hdr_field: cseq <CSeq>:
<1> <ACK>
: DEBUG: <core> [parser/msg_parser.c:202]: DEBUG: get_hdr_body :
content_length=0
: DEBUG: <core> [parser/msg_parser.c:104]: found end of header
: DEBUG: tm [t_lookup.c:527]: t_lookup_request: start searching:
hash=41886, isACK=1
: DEBUG: tm [t_lookup.c:485]: DEBUG: RFC3261 transaction matching failed
: DEBUG: tm [t_lookup.c:709]: DEBUG: t_lookup_request: no transaction found
: DEBUG: tm [t_lookup.c:1148]: DEBUG: t_check_msg: msg id=43 global
id=43 T end=(nil)
: DEBUG: rr [loose.c:111]: No Route headers found
: DEBUG: rr [loose.c:835]: There is no Route HF
: DEBUG: <core> [db_res.c:118]: allocate 48 bytes for result set at
0x7f32b6d1cc30
: DEBUG: db_mysql [km_res.c:68]: 16 columns returned from the query
: DEBUG: <core> [db_res.c:155]: allocate 128 bytes for result names at
0x7f32b6d1ccc8
: DEBUG: <core> [db_res.c:165]: allocate 64 bytes for result types at
0x7f32b6d1bdb8
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[0] at
0x7f32b6d1cc10
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cc10)[0]=[contact]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[1] at
0x7f32b6d1cc78
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cc78)[1]=[expires]
: DEBUG: db_mysql [km_res.c:116]: use DB1_DATETIME result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[2] at
0x7f32b6d1c958
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1c958)[2]=[q]
: DEBUG: db_mysql [km_res.c:111]: use DB1_DOUBLE result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[3] at
0x7f32b6d1cda8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cda8)[3]=[callid]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[4] at
0x7f32b6d1cdc8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cdc8)[4]=[cseq]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[5] at
0x7f32b6d1cde8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cde8)[5]=[flags]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[6] at
0x7f32b6d1ce08
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce08)[6]=[cflags]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[7] at
0x7f32b6d1ce28
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce28)[7]=[user_agent]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[8] at
0x7f32b6d1ce48
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce48)[8]=[received]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[9] at
0x7f32b6d1ce68
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce68)[9]=[path]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[10]
at 0x7f32b6d1ce88
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce88)[10]=[socket]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[11]
at 0x7f32b6d1cea8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cea8)[11]=[methods]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[12]
at 0x7f32b6d1cec8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cec8)[12]=[last_modified]
: DEBUG: db_mysql [km_res.c:116]: use DB1_DATETIME result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[13]
at 0x7f32b6d1cee8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cee8)[13]=[ruid]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[14]
at 0x7f32b6d1cf08
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cf08)[14]=[instance]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[15]
at 0x7f32b6d1cf28
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cf28)[15]=[reg_id]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:169]: no rows returned from the query
: DEBUG: usrloc [udomain.c:599]: aor not found in table aliases
: DEBUG: <core> [db_res.c:81]: freeing 16 columns
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[0] at 0x7f32b6d1cc10
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[1] at 0x7f32b6d1cc78
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[2] at 0x7f32b6d1c958
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[3] at 0x7f32b6d1cda8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[4] at 0x7f32b6d1cdc8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[5] at 0x7f32b6d1cde8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[6] at 0x7f32b6d1ce08
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[7] at 0x7f32b6d1ce28
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[8] at 0x7f32b6d1ce48
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[9] at 0x7f32b6d1ce68
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[10] at 0x7f32b6d1ce88
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[11] at 0x7f32b6d1cea8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[12] at 0x7f32b6d1cec8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[13] at 0x7f32b6d1cee8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[14] at 0x7f32b6d1cf08
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[15] at 0x7f32b6d1cf28
: DEBUG: <core> [db_res.c:94]: freeing result names at 0x7f32b6d1ccc8
: DEBUG: <core> [db_res.c:99]: freeing result types at 0x7f32b6d1bdb8
: DEBUG: <core> [db_res.c:136]: freeing result set at 0x7f32b6d1cc30
: DEBUG: registrar [lookup.c:158]: '' Not found in usrloc
: DEBUG: <core> [db_res.c:118]: allocate 48 bytes for result set at
0x7f32b6d1cc30
: DEBUG: db_mysql [km_res.c:68]: 16 columns returned from the query
: DEBUG: <core> [db_res.c:155]: allocate 128 bytes for result names at
0x7f32b6d1ccc8
: DEBUG: <core> [db_res.c:165]: allocate 64 bytes for result types at
0x7f32b6d1bdb8
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[0] at
0x7f32b6d1cf28
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cf28)[0]=[contact]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[1] at
0x7f32b6d1cf08
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cf08)[1]=[expires]
: DEBUG: db_mysql [km_res.c:116]: use DB1_DATETIME result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[2] at
0x7f32b6d1cee8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cee8)[2]=[q]
: DEBUG: db_mysql [km_res.c:111]: use DB1_DOUBLE result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[3] at
0x7f32b6d1cec8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cec8)[3]=[callid]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[4] at
0x7f32b6d1cea8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cea8)[4]=[cseq]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[5] at
0x7f32b6d1ce88
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce88)[5]=[flags]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[6] at
0x7f32b6d1ce68
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce68)[6]=[cflags]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[7] at
0x7f32b6d1ce48
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce48)[7]=[user_agent]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[8] at
0x7f32b6d1ce28
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce28)[8]=[received]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[9] at
0x7f32b6d1ce08
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1ce08)[9]=[path]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[10]
at 0x7f32b6d1cde8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cde8)[10]=[socket]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[11]
at 0x7f32b6d1cdc8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cdc8)[11]=[methods]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[12]
at 0x7f32b6d1cda8
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cda8)[12]=[last_modified]
: DEBUG: db_mysql [km_res.c:116]: use DB1_DATETIME result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[13]
at 0x7f32b6d1c958
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1c958)[13]=[ruid]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[14]
at 0x7f32b6d1cc78
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cc78)[14]=[instance]
: DEBUG: db_mysql [km_res.c:136]: use DB1_STRING result type
: DEBUG: db_mysql [km_res.c:85]: allocate 16 bytes for RES_NAMES[15]
at 0x7f32b6d1cc10
: DEBUG: db_mysql [km_res.c:92]: RES_NAMES(0x7f32b6d1cc10)[15]=[reg_id]
: DEBUG: db_mysql [km_res.c:100]: use DB1_INT result type
: DEBUG: db_mysql [km_res.c:169]: no rows returned from the query
: DEBUG: usrloc [udomain.c:599]: aor not found in table location
: DEBUG: <core> [db_res.c:81]: freeing 16 columns
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[0] at 0x7f32b6d1cf28
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[1] at 0x7f32b6d1cf08
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[2] at 0x7f32b6d1cee8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[3] at 0x7f32b6d1cec8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[4] at 0x7f32b6d1cea8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[5] at 0x7f32b6d1ce88
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[6] at 0x7f32b6d1ce68
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[7] at 0x7f32b6d1ce48
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[8] at 0x7f32b6d1ce28
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[9] at 0x7f32b6d1ce08
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[10] at 0x7f32b6d1cde8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[11] at 0x7f32b6d1cdc8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[12] at 0x7f32b6d1cda8
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[13] at 0x7f32b6d1c958
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[14] at 0x7f32b6d1cc78
: DEBUG: <core> [db_res.c:85]: freeing RES_NAMES[15] at 0x7f32b6d1cc10
: DEBUG: <core> [db_res.c:94]: freeing result names at 0x7f32b6d1ccc8
: DEBUG: <core> [db_res.c:99]: freeing result types at 0x7f32b6d1bdb8
: DEBUG: <core> [db_res.c:136]: freeing result set at 0x7f32b6d1cc30
: DEBUG: registrar [lookup.c:158]: '' Not found in usrloc
: DEBUG: tm [t_lookup.c:1079]: DEBUG: t_check_msg: msg id=43 global
id=43 T start=(nil)
: DEBUG: tm [t_lookup.c:1154]: DEBUG: t_check_msg: T previously sought
and not found
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [usr_avp.c:644]: DEBUG:destroy_avp_list: destroying list (nil)
: DEBUG: <core> [xavp.c:365]: destroying xavp list (nil)
: DEBUG: <core> [receive.c:293]: receive_msg: cleaning up
ngrep debug in k2 server : k1 <----> k2
U xxx.xxx.xxx.xxx(k1):5002 -> xxx.xxx.xxx.xxx(k2):5003
INVITE sip:5001005@xxx.xxx.xxx.xxx(k2):5003 SIP/2.0.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr=on;nat=yes;did=763.7861>.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-;rport=60496.
Max-Forwards: 69.
Contact: <sip:5978003@122.116.37.55:60496;transport=udp>.
To: "5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2):5003>.
From: "5978003"<sip:5978003@xxx.xxx.xxx.xxx(k1):5002>;tag=1944d063.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
CSeq: 1 INVITE.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE,
SUBSCRIBE, INFO.
Content-Type: application/sdp.
User-Agent: eyeBeam release 1100z stamp 47739.
Content-Length: 312.
P-hint: forward branch.
.
v=0.
o=- 5 2 IN IP4 100.65.104.101.
s=CounterPath eyeBeam 1.5.
c=IN IP4 xxx.xxx.xxx.xxx(k2).
t=0 0.
m=audio 35462 RTP/AVP 98 18 3 101.
a=fmtp:18 annexb=yes.
a=fmtp:101 0-15.
a=rtpmap:98 iLBC/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=sendrecv.
a=x-rtp-session-id:A27021BC28EB48E8BAF43C5BE6389874.
#
U xxx.xxx.xxx.xxx(k2):5003 -> xxx.xxx.xxx.xxx(k1):5002
SIP/2.0 100 trying -- your call is important to us.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-;rport=60496.
To: "5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2):5003>.
From: "5978003"<sip:5978003@xxx.xxx.xxx.xxx(k1):5002>;tag=1944d063.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
CSeq: 1 INVITE.
Server: SIP Server.
Content-Length: 0.
.
#
U xxx.xxx.xxx.xxx(k2):5003 -> 122.116.37.55:35890
INVITE sip:5001005@122.116.37.55:35890;ob SIP/2.0.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr=on;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr=on;nat=yes;did=763.7861>.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k2):5003;branch=z9hG4bKe93a.359d0da4.0.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-;rport=60496.
Max-Forwards: 68.
Contact: <sip:5978003@122.116.37.55:60496;transport=udp>.
To: "5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2):5003>.
From: "5978003"<sip:5978003@xxx.xxx.xxx.xxx(k1):5002>;tag=1944d063.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
CSeq: 1 INVITE.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, NOTIFY, MESSAGE,
SUBSCRIBE, INFO.
Content-Type: application/sdp.
User-Agent: eyeBeam release 1100z stamp 47739.
Content-Length: 312.
.
v=0.
o=- 5 2 IN IP4 100.65.104.101.
s=CounterPath eyeBeam 1.5.
c=IN IP4 xxx.xxx.xxx.xxx(k2).
t=0 0.
m=audio 35462 RTP/AVP 98 18 3 101.
a=fmtp:18 annexb=yes.
a=fmtp:101 0-15.
a=rtpmap:98 iLBC/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=sendrecv.
a=x-rtp-session-id:A27021BC28EB48E8BAF43C5BE6389874.
#
U 122.116.37.55:35890 -> xxx.xxx.xxx.xxx(k2):5003
SIP/2.0 100 Trying.
Via: SIP/2.0/UDP
xxx.xxx.xxx.xxx(k2):5003;received=xxx.xxx.xxx.xxx(k2);branch=z9hG4bKe93a.359d0da4.0.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;rport=60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr;nat=yes;did=763.7861>.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
From: "5978003" <sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
To: "5001005" <sip:5001005@xxx.xxx.xxx.xxx(k2)>.
CSeq: 1 INVITE.
Content-Length: 0.
.
#
U 122.116.37.55:35890 -> xxx.xxx.xxx.xxx(k2):5003
SIP/2.0 180 Ringing.
Via: SIP/2.0/UDP
xxx.xxx.xxx.xxx(k2):5003;received=xxx.xxx.xxx.xxx(k2);branch=z9hG4bKe93a.359d0da4.0.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;rport=60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr;nat=yes;did=763.7861>.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
From: "5978003" <sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
To: "5001005"
<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
CSeq: 1 INVITE.
Contact: "5001005" <sip:5001005@122.116.37.55:35890;ob>.
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
NOTIFY, REFER, MESSAGE, OPTIONS.
Content-Length: 0.
.
#
U xxx.xxx.xxx.xxx(k2):5003 -> xxx.xxx.xxx.xxx(k1):5002
SIP/2.0 180 Ringing.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;rport=60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr;nat=yes;did=763.7861>.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
From: "5978003" <sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
To: "5001005"
<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
CSeq: 1 INVITE.
Contact: "5001005" <sip:5001005@122.116.37.55:35890;ob>.
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
NOTIFY, REFER, MESSAGE, OPTIONS.
Content-Length: 0.
.
#
U 122.116.37.55:35890 -> xxx.xxx.xxx.xxx(k2):5003
SIP/2.0 200 OK.
Via: SIP/2.0/UDP
xxx.xxx.xxx.xxx(k2):5003;received=xxx.xxx.xxx.xxx(k2);branch=z9hG4bKe93a.359d0da4.0.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;rport=60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr;nat=yes;did=763.7861>.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
From: "5978003" <sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
To: "5001005"
<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
CSeq: 1 INVITE.
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
NOTIFY, REFER, MESSAGE, OPTIONS.
Contact: "5001005" <sip:5001005@122.116.37.55:35890;ob>.
Supported: replaces, 100rel, timer, norefersub.
Content-Type: application/sdp.
Content-Length: 230.
.
v=0.
o=- 3595766102 3595766103 IN IP4 122.116.37.55.
s=cpc_med.
c=IN IP4 122.116.37.55.
t=0 0.
m=audio 4008 RTP/AVP 98 101.
a=sendrecv.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=rtpmap:98 iLBC/8000.
a=fmtp:98 mode=20.
#
U xxx.xxx.xxx.xxx(k2):5003 -> xxx.xxx.xxx.xxx(k1):5002
SIP/2.0 200 OK.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;rport=60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr;nat=yes;did=763.7861>.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
From: "5978003" <sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
To: "5001005"
<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
CSeq: 1 INVITE.
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
NOTIFY, REFER, MESSAGE, OPTIONS.
Contact: "5001005" <sip:5001005@122.116.37.55:35890;ob>.
Supported: replaces, 100rel, timer, norefersub.
Content-Type: application/sdp.
Content-Length: 230.
.
v=0.
o=- 3595766102 3595766103 IN IP4 122.116.37.55.
s=cpc_med.
c=IN IP4 122.116.37.55.
t=0 0.
m=audio 4008 RTP/AVP 98 101.
a=sendrecv.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=rtpmap:98 iLBC/8000.
a=fmtp:98 mode=20.
#
U xxx.xxx.xxx.xxx(k1):5002 -> xxx.xxx.xxx.xxx(k2):5003
ACK sip:5001005@xxx.xxx.xxx.xxx(k2):5003;ob SIP/2.0.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr=on>.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKcydzigwkX.
Via: SIP/2.0/UDP
100.65.104.101:60496;received=122.116.37.55;branch=z9hG4bK-d8754z-5479c6361610102b-1---d8754z-;rport=60496.
Max-Forwards: 69.
Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Contact: <sip:5978003@122.116.37.55:60496;transport=udp>.
To:
"5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
From: "5978003"<sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
CSeq: 1 ACK.
User-Agent: eyeBeam release 1100z stamp 47739.
Content-Length: 0.
.
#
U 122.116.37.55:35890 -> xxx.xxx.xxx.xxx(k2):5003
SIP/2.0 200 OK.
Via: SIP/2.0/UDP
xxx.xxx.xxx.xxx(k2):5003;received=xxx.xxx.xxx.xxx(k2);branch=z9hG4bKe93a.359d0da4.0.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;rport=60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr;nat=yes;did=763.7861>.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
From: "5978003" <sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
To: "5001005"
<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
CSeq: 1 INVITE.
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
NOTIFY, REFER, MESSAGE, OPTIONS.
Contact: "5001005" <sip:5001005@122.116.37.55:35890;ob>.
Supported: replaces, 100rel, timer, norefersub.
Content-Type: application/sdp.
Content-Length: 230.
.
v=0.
o=- 3595766102 3595766103 IN IP4 122.116.37.55.
s=cpc_med.
c=IN IP4 122.116.37.55.
t=0 0.
m=audio 4008 RTP/AVP 98 101.
a=sendrecv.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=rtpmap:98 iLBC/8000.
a=fmtp:98 mode=20.
#
U xxx.xxx.xxx.xxx(k2):5003 -> xxx.xxx.xxx.xxx(k1):5002
SIP/2.0 200 OK.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKe93a.851a9236.0.
Via: SIP/2.0/UDP
100.65.104.101:60496;rport=60496;received=122.116.37.55;branch=z9hG4bK-d8754z-8800d531eb69491a-1---d8754z-.
Record-Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr;nat=yes;did=763.7861>.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
From: "5978003" <sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
To: "5001005"
<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
CSeq: 1 INVITE.
Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE,
NOTIFY, REFER, MESSAGE, OPTIONS.
Contact: "5001005" <sip:5001005@122.116.37.55:35890;ob>.
Supported: replaces, 100rel, timer, norefersub.
Content-Type: application/sdp.
Content-Length: 230.
.
v=0.
o=- 3595766102 3595766103 IN IP4 122.116.37.55.
s=cpc_med.
c=IN IP4 122.116.37.55.
t=0 0.
m=audio 4008 RTP/AVP 98 101.
a=sendrecv.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=rtpmap:98 iLBC/8000.
a=fmtp:98 mode=20.
#
U xxx.xxx.xxx.xxx(k1):5002 -> xxx.xxx.xxx.xxx(k2):5003
ACK sip:5001005@xxx.xxx.xxx.xxx(k2):5003;ob SIP/2.0.
Record-Route: <sip:xxx.xxx.xxx.xxx(k1):5002;lr=on>.
Via: SIP/2.0/UDP xxx.xxx.xxx.xxx(k1):5002;branch=z9hG4bKcydzigwkX.
Via: SIP/2.0/UDP
100.65.104.101:60496;received=122.116.37.55;branch=z9hG4bK-d8754z-5479c6361610102b-1---d8754z-;rport=60496.
Max-Forwards: 69.
Route: <sip:xxx.xxx.xxx.xxx(k2):5003;lr;did=763.941>.
Contact: <sip:5978003@122.116.37.55:60496;transport=udp>.
To:
"5001005"<sip:5001005@xxx.xxx.xxx.xxx(k2)>;tag=cjLZLUdZz5lKpi1gtGak.otJWQzet.vf.
From: "5978003"<sip:5978003@xxx.xxx.xxx.xxx(k1)>;tag=1944d063.
Call-ID: NWI3MDllMTI1YmM1MjQ1MDM4ZGVlMmIyZDBiN2Q3ZjI..
CSeq: 1 ACK.
User-Agent: eyeBeam release 1100z stamp 47739.
Content-Length: 0.
.