<html>
<head>
<meta http-equiv="Content-Type" content="text/html; charset=utf-8">
<style type="text/css" style="display:none;"> P {margin-top:0;margin-bottom:0;} </style>
</head>
<body dir="ltr">
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
Hello,</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
<br>
</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
I couldn't find a way to solve this. Maybe it needs to change WITHINDLG or adds domain policy or etc . Kamailio and Asterisk always have different IP address in my setups for simplying and making it easier .</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
<br>
</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
If you have to use asterisk and have only one public IP address then put asterisk to Private IP address and use address translations. this method makes more complexity than have 2-public IP address.</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
<br>
</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
In conclusion , it depends what you can do.</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
<br>
</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
Best Regards</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
<br>
</div>
<div style="font-family: Calibri, Helvetica, sans-serif; font-size: 12pt; color: rgb(0, 0, 0);">
Yasin CANER</div>
<div>
<div id="appendonsend"></div>
<div style="font-family:Calibri,Helvetica,sans-serif; font-size:12pt; color:rgb(0,0,0)">
<br>
</div>
<hr tabindex="-1" style="display:inline-block; width:98%">
<div id="divRplyFwdMsg" dir="ltr"><font face="Calibri, sans-serif" color="#000000" style="font-size:11pt"><b>From:</b> sr-users <sr-users-bounces@lists.kamailio.org> on behalf of Schneuwly Mathias RUAG <Mathias.Schneuwly@ruag.com><br>
<b>Sent:</b> Tuesday, March 12, 2019 11:33 AM<br>
<b>To:</b> Kamailio (SER) - Users Mailing List<br>
<b>Subject:</b> Re: [SR-Users] ACK not forwarding to Asterisk</font>
<div> </div>
</div>
<div dir="ltr" style="font-size:12pt; color:#000000; background-color:#FFFFFF; font-family:Calibri,Arial,Helvetica,sans-serif">
<div dir="ltr" style="font-size:12pt; color:#000000; background-color:#FFFFFF; font-family:Calibri,Arial,Helvetica,sans-serif">
<div>
<div>​​Hi Yasin<br>
</div>
<div><br>
</div>
<div>Thanks for your reply!<br>
</div>
<div><br>
</div>
<div>That means my setup does not work if Kamailio and Asterisk are sitting on the same IP. Or is there something I can do? Do you have a proposal what I could change?<br>
</div>
<div><br>
</div>
<div>Regards<br>
</div>
<div>Mathias<br>
</div>
<div><br>
</div>
<div>Config snippet of WITHINDLG:<br>
</div>
<div>...<br>
</div>
<div>
<div># Handle requests within SIP dialogs</div>
<div>route[WITHINDLG] {</div>
<div> xlog("XXXXXXXXXXXXXXXXXXXXXXX\nWITHINDLG\n");</div>
<div> if (!has_totag()) return;</div>
<div><br>
</div>
<div> # sequential request withing a dialog should</div>
<div> # take the path determined by record-routing</div>
<div> if (loose_route()) {</div>
<div> xlog("XXXXXXXXXXXXXXXXXXXXXXX\nLoose route\n");</div>
<div> if (is_method("BYE")) {</div>
<div> setflag(FLT_ACC); # do accounting ...</div>
<div> setflag(FLT_ACCFAILED); # ... even if the transaction fails</div>
<div> } else if ( is_method("NOTIFY") ) {</div>
<div> # Add Record-Route for in-dialog NOTIFY as per RFC 6665.</div>
<div> record_route();</div>
<div> }</div>
<div> route(RELAY);</div>
<div> exit;</div>
<div> }</div>
<div><br>
</div>
<div> if (is_method("SUBSCRIBE") && uri == myself) {</div>
<div> # in-dialog subscribe requests</div>
<div> route(PRESENCE);</div>
<div> exit;</div>
<div> }</div>
<div> xlog("XXXXXXXXXXXXXXXXXXXXXXX\nWITHINDLG\n");</div>
<div> if ( is_method("ACK") ) {</div>
<div> xlog("XXXXXXXXXXXXXXXXXXXXXXX\nACK\n");</div>
<div> if ( t_check_trans() ) {</div>
<div> xlog("XXXXXXXXXXXXXXXXXXXXXXX\nt_check_trans\n");</div>
<div> # no loose-route, but stateful ACK;</div>
<div> # must be an ACK after a 487</div>
<div> # or e.g. 404 from upstream server</div>
<div> route(RELAY);</div>
<div> exit;</div>
<div> } else {</div>
<div> xlog("XXXXXXXXXXXXXXXXXXXXXXX\nignore\n");</div>
<div> # ACK without matching transaction ... ignore and discard</div>
<div> exit;</div>
<div> }</div>
<div> }</div>
<div> sl_send_reply("404","Not here");</div>
<div> exit;</div>
<div>}</div>
<div><br>
​<br>
</div>
<br>
</div>
<div>...</div>
<div><br>
</div>
<div>Following the log output of the relevant OK and ACK:<br>
</div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/1091) [[SIP/2.0 200 OK 0D 0A Via: SIP/2.0/UDP 10.40.8.104:5070;branch=z9hG4bK4825.fc814778ec04597ae4759a9771bfef0]] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:620]: parse_msg(): SIP Reply (status): </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:622]: parse_msg(): version: <SIP/2.0> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:624]: parse_msg(): status: <200> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:626]: parse_msg(): reason: <OK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK4825.fc814778ec04597ae4759a9771bfef09.0>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 234, <received> = <10.40.8.104>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 234, <received> = <10.40.6.188>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <60223>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjBBr32NDnGLx0KwymDtyAXs.rIuFIwAdi>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=78 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:511]: parse_headers(): this is the second via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=as21517b15 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [44]; uri=[sip:004112345@10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body [<sip:004112345@10.40.8.104>], to tag [as21517b15] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <27457> <INVITE> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/receive.c:245]: receive_msg(): --- received sip message - reply - call-id: [otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy] - cseq: [27457 INVITE] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=271 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1043]: t_check_msg(): msg (0xb72fb410) id=26/18447 global id=25/18447 T start=0xffffffff </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:920]: t_reply_matching(): t_reply_matching: hash 21124 label 0 branch 0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:974]: t_reply_matching(): reply (0xb72fb410) matched an active transaction (T=0xb4931af4)! </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_hooks.c:258]: run_trans_callbacks_internal(): DBG: trans=0xb4931af4, callback type 2, id 0 entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} acc [acc_logic.c:682]: tmcb_func(): acc callback called for t(0xb4931af4) event type 2, reply code 200 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} acc [acc_logic.c:414]: should_acc_reply(): probing acc state - code: 200 flags: 0x2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} acc [acc_logic.c:446]: should_acc_reply(): acc is on </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_hooks.c:258]: run_trans_callbacks_internal(): DBG: trans=0xb4931af4, callback type 2, id 0 entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_profile.c:536]: set_current_dialog(): setting current dialog [3438:8415] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1113]: t_check_msg(): msg (0xb72fb410) id=26/18447 global id=26/18447 T end=0xb4931af4 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_reply.c:2243]: reply_received(): transaction found - T:0xb4931af4 branch:0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_reply.c:2258]: reply_received(): org. status uas=200, uac[0]=200 local=0 is_invite=1) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: incoming reply </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_reply.c:1266]: t_should_relay_response(): ->>>>>>>>> T_code=200, new_code=200 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_reply.c:1271]: t_should_relay_response(): 200 INV after final sent </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_reply.c:1824]: relay_reply(): reply status=1 branch=0, save=0, relay=0 icode=0 msg status=200 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_hooks.c:258]: run_trans_callbacks_internal(): DBG: trans=0xb4931af4, callback type 32, id 0 entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/msg_translator.c:2288]: generate_res_buf_from_sip_res(): old size: 1091, new size: 981 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/msg_translator.c:2306]: generate_res_buf_from_sip_res(): copied size: orig:126, new: 16, rest: 965 msg= SIP/2.0 200 OK^M Via: SIP/2.0/UDP
10.40.6.188:60223;received=10.40.6.188;rport=60223;branch=z9hG4bKPjBBr32NDnGLx0KwymDtyAXs.rIuFIwAdi^M Record-Route: <sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02>^M From: <sip:proxydevice@10.40.8.104>;tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP^M
To: <sip:004112345@10.40.8.104>;tag=as21517b15^M Call-ID: otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy^M CSeq: 27457 INVITE^M Server: Asterisk PBX 12.3.2^M Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH, MESSAGE^M Supported: replaces,
timer^M Session-Expires: 1800;refresher=uas^M Contact: <sip:004112345@10.40.8.104:5060>^M Content-Type: application/sdp^M Require: timer^M Content-Length: 271^M ^M v=0^M o=root 623479861 623479861 IN IP4 10.40.8.104^M s=Asterisk PBX 12.3.2^M </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_reply.c:305]: update_totag_set(): to-tag retransmission </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_reply.c:2016]: relay_reply(): reply buffer sent out </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:441]: receive_msg(): reply-route executed in: 490 usec </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_var.c:97]: cb_dlg_locals_reset(): resetting the local dialog shortcuts on script callback: 2147483652 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN last message repeated 5 times</div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/xavp.c:495]: xavp_destroy_list(): destroying xavp list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18447]: DEBUG: {2 27457 INVITE otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:457]: receive_msg(): cleaning up </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/442) [[ACK sip:004112345@10.40.8.104:5060 SIP/2.0 0D 0A Via: SIP/2.0/UDP 10.40.6.188:60223;rport;branch=z9hG4bKP]] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request: </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg(): method: <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg(): uri: <sip:004112345@10.40.8.104:5060> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg(): version: <SIP/2.0> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=as21517b15 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [44]; uri=[sip:004112345@10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body [<sip:004112345@10.40.8.104>], to tag [as21517b15] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <27457> <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/receive.c:245]: receive_msg(): --- received sip message - request - call-id: [otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy] - cseq: [27457 ACK] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:295]: receive_msg(): preparing to run routing scripts... </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sl [sl_funcs.c:397]: sl_filter_ACK(): too late to be a local ACK! </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:769]: internal_get_dlg(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:772]: internal_get_dlg(): dialog callid='otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy' found on entry 3438, dir=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_profile.c:536]: set_current_dialog(): setting current dialog [3438:8415] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:1158]: next_state_dlg(): dialog 0xb4934aec changed from state 3 to state 4, due event 6 (ref 3) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_timer.c:110]: insert_dialog_timer_unsafe(): inserting 0xb4934b30 for 12143697 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_handlers.c:1475]: dlg_onroute(): confirming ACK successfully processed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} pv [pv_core.c:1031]: pv_get_useragent(): no User-Agent header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:558]: check_cl(): check_cl entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:583]: check_cl(): check_cl passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:632]: check_expires_value(): no expires header found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:728]: check_parse_uris(): check_parse_uris entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:732]: check_parse_uris(): parsing ruri </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:746]: check_parse_uris(): looking up From header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:786]: check_parse_uris(): parsing From URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:804]: check_parse_uris(): looking up To header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:826]: check_parse_uris(): check_parse_uris(): parsing To URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:871]: check_parse_uris(): check_parse_uris passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} siputils [checks.c:123]: has_totag(): totag found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:91]: is_preloaded(): is_preloaded: No </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/socket_info.c:564]: grep_sock_info(): checking if host==us: 11==11 && [10.40.8.104] == [10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/socket_info.c:567]: grep_sock_info(): checking if port 5070 (advertise 5070) matches port 5060 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:677]: after_strict(): Next hop: 'sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02' is loose router </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:727]: after_strict(): The last route URI: 'sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02' </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX Loose route </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1346]: t_newtran(): msg (0xb72fb410) id=25/18442 global id=24/18442 T start=0xffffffff </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:500]: t_lookup_request(): start searching: hash=21124, isACK=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:458]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:682]: t_lookup_request(): no transaction found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_funcs.c:287]: t_relay_to(): forwarding ACK statelessly </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/dns_cache.c:3193]: dns_srv_sip_resolve(): (10.40.8.104, 0, 0), ip, ret=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: 29cbe80853cc3d43347f3c0b4b643e4c </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/forward.c:557]: forward_request(): Sending: ACK sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02 SIP/2.0^M Via:
SIP/2.0/UDP 10.40.8.104:5070;branch=z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0^M Via: SIP/2.0/UDP 10.40.6.188:60223;received=10.40.6.188;rport=60223;branch=z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ^M Max-Forwards: 69^M From: <sip:proxydevice@10.40.8.104>;tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP^M
To: <sip:004112345@10.40.8.104>;tag=as21517b15^M Call-ID: otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy^M CSeq: 27457 ACK^M Content-Length: 0^M ^M . </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/forward.c:559]: forward_request(): orig. len=442, new_len=517, proto=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:353]: receive_msg(): request-route executed in: 936 usec </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/517) [[ACK sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02 SIP/2.0 0D 0A Via: SIP/2.0]] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request: </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg(): method: <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg(): uri: <sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg(): version: <SIP/2.0> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/xavp.c:495]: xavp_destroy_list(): destroying xavp list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18442]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:457]: receive_msg(): cleaning up </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 234, <received> = <10.40.6.188>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <60223>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=78 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:511]: parse_headers(): this is the second via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=as21517b15 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [44]; uri=[sip:004112345@10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body [<sip:004112345@10.40.8.104>], to tag [as21517b15] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <27457> <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/receive.c:245]: receive_msg(): --- received sip message - request - call-id: [otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy] - cseq: [27457 ACK] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:295]: receive_msg(): preparing to run routing scripts... </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sl [sl_funcs.c:397]: sl_filter_ACK(): too late to be a local ACK! </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:769]: internal_get_dlg(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:772]: internal_get_dlg(): dialog callid='otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy' found on entry 3438, dir=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_profile.c:536]: set_current_dialog(): setting current dialog [3438:8415] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:1158]: next_state_dlg(): dialog 0xb4934aec changed from state 4 to state 4, due event 6 (ref 3) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_timer.c:110]: insert_dialog_timer_unsafe(): inserting 0xb4934b30 for 12143697 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_handlers.c:1480]: dlg_onroute(): sequential request successfully processed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [record.c:925]: add_rr_param(): rr_param_buf=<;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} pv [pv_core.c:1031]: pv_get_useragent(): no User-Agent header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 69 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:558]: check_cl(): check_cl entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:583]: check_cl(): check_cl passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:632]: check_expires_value(): no expires header found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:728]: check_parse_uris(): check_parse_uris entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:732]: check_parse_uris(): parsing ruri </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:746]: check_parse_uris(): looking up From header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:786]: check_parse_uris(): parsing From URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:804]: check_parse_uris(): looking up To header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:826]: check_parse_uris(): check_parse_uris(): parsing To URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:871]: check_parse_uris(): check_parse_uris passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} siputils [checks.c:123]: has_totag(): totag found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:114]: find_first_route(): No Route headers found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:961]: loose_route(): There is no Route HF </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX ACK </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1043]: t_check_msg(): msg (0xb72fb410) id=26/18443 global id=25/18443 T start=0xffffffff </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:500]: t_lookup_request(): start searching: hash=21124, isACK=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:458]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:682]: t_lookup_request(): no transaction found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1113]: t_check_msg(): msg (0xb72fb410) id=26/18443 global id=26/18443 T end=(nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX ignore </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:353]: receive_msg(): request-route executed in: 737 usec </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN last message repeated 5 times</div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/xavp.c:495]: xavp_destroy_list(): destroying xavp list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18443]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:457]: receive_msg(): cleaning up </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/442) [[ACK sip:004112345@10.40.8.104:5060 SIP/2.0 0D 0A Via: SIP/2.0/UDP 10.40.6.188:60223;rport;branch=z9hG4bKP]] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request: </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg(): method: <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg(): uri: <sip:004112345@10.40.8.104:5060> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg(): version: <SIP/2.0> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=as21517b15 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [44]; uri=[sip:004112345@10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body [<sip:004112345@10.40.8.104>], to tag [as21517b15] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <27457> <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/receive.c:245]: receive_msg(): --- received sip message - request - call-id: [otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy] - cseq: [27457 ACK] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:295]: receive_msg(): preparing to run routing scripts... </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sl [sl_funcs.c:397]: sl_filter_ACK(): too late to be a local ACK! </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/442) [[ACK sip:004112345@10.40.8.104:5060 SIP/2.0 0D 0A Via: SIP/2.0/UDP 10.40.6.188:60223;rport;branch=z9hG4bKP]] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request: </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg(): method: <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:769]: internal_get_dlg(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg(): uri: <sip:004112345@10.40.8.104:5060> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg(): version: <SIP/2.0> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <n/a>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:772]: internal_get_dlg(): dialog callid='otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy' found on entry 3438, dir=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_profile.c:536]: set_current_dialog(): setting current dialog [3438:8415] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:1158]: next_state_dlg(): dialog 0xb4934aec changed from state 4 to state 4, due event 6 (ref 3) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=as21517b15 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_timer.c:110]: insert_dialog_timer_unsafe(): inserting 0xb4934b30 for 12143697 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_handlers.c:1480]: dlg_onroute(): sequential request successfully processed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [44]; uri=[sip:004112345@10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [record.c:925]: add_rr_param(): rr_param_buf=<;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body [<sip:004112345@10.40.8.104>], to tag [as21517b15] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <27457> <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/receive.c:245]: receive_msg(): --- received sip message - request - call-id: [otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy] - cseq: [27457 ACK] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} pv [pv_core.c:1031]: pv_get_useragent(): no User-Agent header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:295]: receive_msg(): preparing to run routing scripts... </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sl [sl_funcs.c:397]: sl_filter_ACK(): too late to be a local ACK! </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:769]: internal_get_dlg(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:772]: internal_get_dlg(): dialog callid='otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy' found on entry 3438, dir=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_profile.c:536]: set_current_dialog(): setting current dialog [3438:8415] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:1158]: next_state_dlg(): dialog 0xb4934aec changed from state 4 to state 4, due event 6 (ref 3) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_timer.c:110]: insert_dialog_timer_unsafe(): inserting 0xb4934b30 for 12143697 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_handlers.c:1480]: dlg_onroute(): sequential request successfully processed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [record.c:925]: add_rr_param(): rr_param_buf=<;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} pv [pv_core.c:1031]: pv_get_useragent(): no User-Agent header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:558]: check_cl(): check_cl entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:583]: check_cl(): check_cl passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:632]: check_expires_value(): no expires header found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:728]: check_parse_uris(): check_parse_uris entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:732]: check_parse_uris(): parsing ruri </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:746]: check_parse_uris(): looking up From header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:786]: check_parse_uris(): parsing From URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:558]: check_cl(): check_cl entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:804]: check_parse_uris(): looking up To header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:583]: check_cl(): check_cl passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:826]: check_parse_uris(): check_parse_uris(): parsing To URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:871]: check_parse_uris(): check_parse_uris passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:632]: check_expires_value(): no expires header found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:728]: check_parse_uris(): check_parse_uris entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:732]: check_parse_uris(): parsing ruri </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} siputils [checks.c:123]: has_totag(): totag found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:746]: check_parse_uris(): looking up From header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:91]: is_preloaded(): is_preloaded: No </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:786]: check_parse_uris(): parsing From URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:804]: check_parse_uris(): looking up To header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/socket_info.c:564]: grep_sock_info(): checking if host==us: 11==11 && [10.40.8.104] == [10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:826]: check_parse_uris(): check_parse_uris(): parsing To URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:871]: check_parse_uris(): check_parse_uris passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/socket_info.c:567]: grep_sock_info(): checking if port 5070 (advertise 5070) matches port 5060 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:677]: after_strict(): Next hop: 'sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02' is loose router </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:727]: after_strict(): The last route URI: 'sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02' </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} siputils [checks.c:123]: has_totag(): totag found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX Loose route </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:91]: is_preloaded(): is_preloaded: No </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/socket_info.c:564]: grep_sock_info(): checking if host==us: 11==11 && [10.40.8.104] == [10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1346]: t_newtran(): msg (0xb72fb410) id=27/18445 global id=26/18445 T start=0xffffffff </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/socket_info.c:567]: grep_sock_info(): checking if port 5070 (advertise 5070) matches port 5060 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:500]: t_lookup_request(): start searching: hash=21124, isACK=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:677]: after_strict(): Next hop: 'sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02' is loose router </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:727]: after_strict(): The last route URI: 'sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02' </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:458]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX Loose route </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:682]: t_lookup_request(): no transaction found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1346]: t_newtran(): msg (0xb72fb410) id=25/18444 global id=24/18444 T start=0xffffffff </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_funcs.c:287]: t_relay_to(): forwarding ACK statelessly </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:500]: t_lookup_request(): start searching: hash=21124, isACK=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:458]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/dns_cache.c:3193]: dns_srv_sip_resolve(): (10.40.8.104, 0, 0), ip, ret=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: 29cbe80853cc3d43347f3c0b4b643e4c </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/forward.c:557]: forward_request(): Sending: ACK sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02 SIP/2.0^M Via:
SIP/2.0/UDP 10.40.8.104:5070;branch=z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0^M Via: SIP/2.0/UDP 10.40.6.188:60223;received=10.40.6.188;rport=60223;branch=z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ^M Max-Forwards: 69^M From: <sip:proxydevice@10.40.8.104>;tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP^M
To: <sip:004112345@10.40.8.104>;tag=as21517b15^M Call-ID: otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy^M CSeq: 27457 ACK^M Content-Length: 0^M ^M . </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:682]: t_lookup_request(): no transaction found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/forward.c:559]: forward_request(): orig. len=442, new_len=517, proto=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_funcs.c:287]: t_relay_to(): forwarding ACK statelessly </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/dns_cache.c:3193]: dns_srv_sip_resolve(): (10.40.8.104, 0, 0), ip, ret=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/md5utils.c:67]: MD5StringArray(): MD5 calculated: 29cbe80853cc3d43347f3c0b4b643e4c </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/517) [[ACK sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02 SIP/2.0 0D 0A Via: SIP/2.0]] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:353]: receive_msg(): request-route executed in: 2883 usec </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/forward.c:557]: forward_request(): Sending: ACK sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02 SIP/2.0^M Via:
SIP/2.0/UDP 10.40.8.104:5070;branch=z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0^M Via: SIP/2.0/UDP 10.40.6.188:60223;received=10.40.6.188;rport=60223;branch=z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ^M Max-Forwards: 69^M From: <sip:proxydevice@10.40.8.104>;tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP^M
To: <sip:004112345@10.40.8.104>;tag=as21517b15^M Call-ID: otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy^M CSeq: 27457 ACK^M Content-Length: 0^M ^M . </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request: </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg(): method: <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg(): uri: <sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg(): version: <SIP/2.0> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/forward.c:559]: forward_request(): orig. len=442, new_len=517, proto=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:353]: receive_msg(): request-route executed in: 2527 usec </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/517) [[ACK sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02 SIP/2.0 0D 0A Via: SIP/2.0]] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:610]: parse_msg(): SIP Request: </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:612]: parse_msg(): method: <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:614]: parse_msg(): uri: <sip:10.40.8.104:5070;lr;ftag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 234, <received> = <10.40.6.188>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <60223>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/xavp.c:495]: xavp_destroy_list(): destroying xavp list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18445]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:457]: receive_msg(): cleaning up </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:616]: parse_msg(): version: <SIP/2.0> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=78 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:511]: parse_headers(): this is the second via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=as21517b15 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/xavp.c:495]: xavp_destroy_list(): destroying xavp list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18444]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:457]: receive_msg(): cleaning up </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:500]: parse_headers(): this is the first via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [44]; uri=[sip:004112345@10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 234, <received> = <10.40.6.188>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 235, <rport> = <60223>; state=6 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body [<sip:004112345@10.40.8.104>], to tag [as21517b15] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <27457> <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKPjvd1MSxMjv6dfOGdbAVxKz.iPtydNiEtQ>; state=16 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/receive.c:245]: receive_msg(): --- received sip message - request - call-id: [otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy] - cseq: [27457 ACK] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:498]: parse_headers(): Via found, flags=78 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:511]: parse_headers(): this is the second via </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:295]: receive_msg(): preparing to run routing scripts... </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=as21517b15 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sl [sl_funcs.c:397]: sl_filter_ACK(): too late to be a local ACK! </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:171]: get_hdr_field(): <To> [44]; uri=[sip:004112345@10.40.8.104] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:174]: get_hdr_field(): to body [<sip:004112345@10.40.8.104>], to tag [as21517b15] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:152]: get_hdr_field(): cseq <CSeq>: <27457> <ACK> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/receive.c:245]: receive_msg(): --- received sip message - request - call-id: [otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy] - cseq: [27457 ACK] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:769]: internal_get_dlg(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: <core> [core/parser/msg_parser.c:89]: get_hdr_field(): found end of header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:295]: receive_msg(): preparing to run routing scripts... </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:772]: internal_get_dlg(): dialog callid='otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy' found on entry 3438, dir=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sl [sl_funcs.c:397]: sl_filter_ACK(): too late to be a local ACK! </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_profile.c:536]: set_current_dialog(): setting current dialog [3438:8415] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:1158]: next_state_dlg(): dialog 0xb4934aec changed from state 4 to state 4, due event 6 (ref 3) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=1DoN4DknAgMG5nSNVGynmZgOtY9Ap6nP </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_timer.c:110]: insert_dialog_timer_unsafe(): inserting 0xb4934b30 for 12143697 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_handlers.c:1480]: dlg_onroute(): sequential request successfully processed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:769]: internal_get_dlg(): ref dlg 0xb4934aec with 1 -> 4 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:772]: internal_get_dlg(): dialog callid='otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy' found on entry 3438, dir=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [record.c:925]: add_rr_param(): rr_param_buf=<;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_profile.c:536]: set_current_dialog(): setting current dialog [3438:8415] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} pv [pv_core.c:1031]: pv_get_useragent(): no User-Agent header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 69 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:1158]: next_state_dlg(): dialog 0xb4934aec changed from state 4 to state 4, due event 6 (ref 3) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_timer.c:110]: insert_dialog_timer_unsafe(): inserting 0xb4934b30 for 12143697 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_handlers.c:1480]: dlg_onroute(): sequential request successfully processed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [record.c:925]: add_rr_param(): rr_param_buf=<;did=e6d.fd02> </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} pv [pv_core.c:1031]: pv_get_useragent(): no User-Agent header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 69 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:558]: check_cl(): check_cl entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:583]: check_cl(): check_cl passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:632]: check_expires_value(): no expires header found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:305]: check_required_headers(): check_required_headers entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:728]: check_parse_uris(): check_parse_uris entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:732]: check_parse_uris(): parsing ruri </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:313]: check_required_headers(): check_required_headers passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:479]: check_cseq_method(): check_cseq_method entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:746]: check_parse_uris(): looking up From header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:786]: check_parse_uris(): parsing From URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:512]: check_cseq_method(): check_cseq_method passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:521]: check_cseq_value(): check_cseq_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:804]: check_parse_uris(): looking up To header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:826]: check_parse_uris(): check_parse_uris(): parsing To URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:549]: check_cseq_value(): check_cseq_value passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:558]: check_cl(): check_cl entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:871]: check_parse_uris(): check_parse_uris passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:583]: check_cl(): check_cl passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:595]: check_expires_value(): check_expires_value entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:632]: check_expires_value(): no expires header found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:728]: check_parse_uris(): check_parse_uris entered </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} siputils [checks.c:123]: has_totag(): totag found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:114]: find_first_route(): No Route headers found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:961]: loose_route(): There is no Route HF </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:732]: check_parse_uris(): parsing ruri </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:746]: check_parse_uris(): looking up From header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX ACK </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1043]: t_check_msg(): msg (0xb72fb410) id=24/18448 global id=23/18448 T start=0xffffffff </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:500]: t_lookup_request(): start searching: hash=21124, isACK=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:786]: check_parse_uris(): parsing From URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:458]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:804]: check_parse_uris(): looking up To header </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:826]: check_parse_uris(): check_parse_uris(): parsing To URI </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:682]: t_lookup_request(): no transaction found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1113]: t_check_msg(): msg (0xb72fb410) id=24/18448 global id=24/18448 T end=(nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX ignore </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:353]: receive_msg(): request-route executed in: 1941 usec </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity.c:871]: check_parse_uris(): check_parse_uris passed </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} sanity [sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} siputils [checks.c:123]: has_totag(): totag found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:114]: find_first_route(): No Route headers found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} rr [loose.c:961]: loose_route(): There is no Route HF </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX WITHINDLG </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX ACK </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1043]: t_check_msg(): msg (0xb72fb410) id=27/18446 global id=26/18446 T start=0xffffffff </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:500]: t_lookup_request(): start searching: hash=21124, isACK=1 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:458]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bK4825.29cbe80853cc3d43347f3c0b4b643e4c.0] </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:682]: t_lookup_request(): no transaction found </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} tm [t_lookup.c:1113]: t_check_msg(): msg (0xb72fb410) id=27/18446 global id=27/18446 T end=(nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: ERROR: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <script>: XXXXXXXXXXXXXXXXXXXXXXX ignore </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:353]: receive_msg(): request-route executed in: 2123 usec </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:712]: dlg_lookup(): ref dlg 0xb4934aec with 1 -> 3 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/xavp.c:495]: xavp_destroy_list(): destroying xavp list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18448]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:457]: receive_msg(): cleaning up </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:714]: dlg_lookup(): dialog id=8415 found on entry 3438 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:957]: dlg_unref_helper(): unref op on 0xb4934aec with 1 from dlg_hash.c:975 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} dialog [dlg_hash.c:961]: dlg_unref_helper(): unref dlg 0xb4934aec with 1 -> 2 </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil) </div>
<div>Mar 12 09:21:43 oAN last message repeated 5 times</div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/xavp.c:495]: xavp_destroy_list(): destroying xavp list (nil) </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18446]: DEBUG: {1 27457 ACK otoEsJ246gIFd.4F3Z6nE7PwA9XsgKCy} <core> [core/receive.c:457]: receive_msg(): cleaning up </div>
<div>Mar 12 09:21:43 oAN /usr/sbin/kamailio[18449]: DEBUG: <core> [core/udp_server.c:492]: udp_rcv_loop(): received on udp socket: (106/100/1091) [[SIP/2.0 200 OK 0D 0A Via: SIP/2.0/UDP 10.40.8.104:5070;branch=z9hG4bK4825.fc814778ec04597ae4759a9771bfef0]] <br>
</div>
</div>
</div>
</div>
</div>
</body>
</html>