<html><head><meta http-equiv="Content-Type" content="text/html; charset=utf-8"></head><body style="word-wrap: break-word; -webkit-nbsp-mode: space; line-break: after-white-space;" class="">You’re right that SIPp is not adding record route.<div class="">I tried adding the ‘rrs’ flag as shown on the default scenarios but did not work.</div><div class="">Working SIPp scenarios would be appreciated.</div><div class=""><br class=""></div><div class="">Thanks<br class=""><div><br class=""><div class="">On Nov 11, 2021, at 2:42 PM, ‪M S‬ <<a href="mailto:shaheryarkh@gmail.com" class="">shaheryarkh@gmail.com</a>> wrote:</div><br class="Apple-interchange-newline"><div class=""><div dir="auto" style="caret-color: rgb(0, 0, 0); font-family: Helvetica; font-size: 12px; font-style: normal; font-variant-caps: normal; font-weight: normal; letter-spacing: normal; text-align: start; text-indent: 0px; text-transform: none; white-space: normal; word-spacing: 0px; -webkit-text-stroke-width: 0px; text-decoration: none;" class="">Seems you forgot to add record route to invite, as a result there is no Route header in ACK, so loose route fails. <div class=""><br class=""></div><div class="">Additionally there is no contact alias, so routing via alias also fails. <div class=""><br class=""></div><div class="">Also it seems you are not creating SIP transactions and dialogs in script, you just blindly receiving sip request from one end and throwing it out to the other end!</div><div class=""><br class=""></div><div class="">So only possible way to route ACK is to set destination URI, same way you do for INVITE. You will have to do that for EVERY sip request, unless you make your script intelligent enough to create and recognize sip transactions & dialogs properly.<div class=""><br class=""></div><div class="">Hope this helps.</div><div class=""><br class=""></div><div class="">--</div><div class="">Muhammad Shahzad Shafi</div><div class="">Tel: +49 176 99 83 10 85<br class=""><br class="">Sent from my Huawei P40 5G phone</div></div></div></div><div style="caret-color: rgb(0, 0, 0); font-family: Helvetica; font-size: 12px; font-style: normal; font-variant-caps: normal; font-weight: normal; letter-spacing: normal; text-align: start; text-indent: 0px; text-transform: none; white-space: normal; word-spacing: 0px; -webkit-text-stroke-width: 0px; text-decoration: none; line-height: 1.5;" class=""><br class=""><br class="">-------- Original message --------<br class="">From: Emilio Panighetti <<a href="mailto:emiliop@operalogic.com" class="">emiliop@operalogic.com</a>><br class="">Date: Thu, 11 Nov 2021, 18:44<br class="">To: "Kamailio (SER) - Users Mailing List" <<a href="mailto:sr-users@lists.kamailio.org" class="">sr-users@lists.kamailio.org</a>><br class="">Subject: [SR-Users] Kamailio dropping ACKs<br class=""><blockquote class=""><div style="word-wrap: break-word;" class="">Working on a proof of concept with Kamailio 5.5.2 (Installed via kamailio-5.5.2-0.el8.centos.x86_64 RPM from<span class="Apple-converted-space"> </span><a href="http://rpm.kamailio.org/" class="">rpm.kamailio.org</a>).<div class="">Also note that this is using the LUA interface</div><div class=""><br class=""></div><div class="">Running a simple SIPp scenario without registration. Routing is set with in Lua:</div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_relay Check for Base Route\n");<br class="">    if KSR.is_INVITE() and KSR.siputils.has_totag() < 0 then<br class="">       <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_relay Base Route\n");<br class="">        --KSR.sl.send_reply("503", "OLGX Debug");<br class="">       <span class="Apple-converted-space"> </span>KSR.setdsturi("<a href="sip:192.168.1.14:5060" class="">sip:192.168.1.14:5060</a>");<br class="">        --KSR.pv.sets("$du", "<a href="sip:192.168.1.12:5062" class="">sip:192.168.1.12:5062</a>");<br class="">    end</font></div><div class=""><br class=""></div><div class="">The problem is that Kamailio is dropping the ACK to the 200 OK from the UAS. Wireshark shows that the UAS is retransmitting the 200 OK and the ACK is not being forwarded from the UAC to the UAS.</div><div class=""><br class=""></div><div class=""><span id="cid:C0AC2B6A-AA99-4AB4-B0C8-E52BEE66DC89@verizon.net"><PastedGraphic-2.png></span></div><div class="">Within the Lua config script:</div><div class=""><br class=""></div><div class=""><font face="Consolas" class="">-- Handle requests within SIP dialogs<br class="">function ksr_route_withindlg()<br class="">    if KSR.siputils.has_totag() < 0 then return 1; end<br class="">   <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg has to-tag, it is within a dialog\n");<br class=""><br class="">    -- sequential request within a dialog should<br class="">    -- take the path determined by record-routing<br class="">    if KSR.rr.loose_route() > 0 then<br class="">        ksr_route_dlguri();<br class="">        if KSR.is_BYE() then<br class="">           <span class="Apple-converted-space"> </span>KSR.setflag(FLT_ACC); -- do accounting ...<br class="">           <span class="Apple-converted-space"> </span>KSR.setflag(FLT_ACCFAILED); -- ... even if the transaction fails<br class="">        elseif KSR.is_ACK() then<br class="">            -- ACK is forwarded statelessly<br class="">           <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg Forwarding ACK\n");<br class="">            ksr_route_natmanage();<br class="">        elseif KSR.is_NOTIFY() then<br class="">            -- Add Record-Route for in-dialog NOTIFY as per RFC 6665.<br class="">           <span class="Apple-converted-space"> </span>KSR.rr.record_route();<br class="">        end<br class="">       <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg loose route calling ksr_route_relay\n");<br class="">        ksr_route_relay();<br class="">       <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg exit\n");<br class="">       <span class="Apple-converted-space"> </span>KSR.x.exit();<br class="">    end<br class="">    if KSR.is_ACK() then<br class="">        if KSR.tm.t_check_trans() > 0 then<br class="">            -- no loose-route, but stateful ACK;<br class="">            -- must be an ACK after a 487<br class="">            -- or e.g. 404 from upstream server<br class="">           <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg is ACK calling ksr_route_relay\n");<br class="">            ksr_route_relay();<br class="">           <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg exit\n");<br class="">           <span class="Apple-converted-space"> </span>KSR.x.exit();<br class="">        else<br class="">            -- ACK without matching transaction ... ignore and discard<br class="">           <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg Unknown ACK exit\n");<br class="">           <span class="Apple-converted-space"> </span>KSR.x.exit();<br class="">        end<br class="">    end<br class="">   <span class="Apple-converted-space"> </span>KSR.sl.sl_send_reply(404, "Not here");<br class="">   <span class="Apple-converted-space"> </span>KSR.dbg("EP: ksr_route_withindlg exit after 404\n");<br class="">   <span class="Apple-converted-space"> </span>KSR.x.exit();<br class="">end</font><br class=""><br class=""></div><div class="">And logs for the ACK:</div><div class=""><br class=""></div><div class=""><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/udp_server.c:493]: udp_rcv_loop(): received on udp socket: (106/100/385) [[ACK <a href="sip:service@192.168.1.15:5060" class="">sip:service@192.168.1.15:5060</a> SIP/2.0 0D  0A Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK-1091869]]</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_fline.c:249]: parse_first_line(): first line type 1 (request) flags 1</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:677]: parse_msg(): SIP Request:</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:679]: parse_msg():  method:  <ACK></font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:681]: parse_msg():  uri:     <<a href="sip:service@192.168.1.15:5060" class="">sip:service@192.168.1.15:5060</a>></font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:683]: parse_msg():  version: <SIP/2.0></font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [Via] type 1</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK-1091869-1-5>; state=16</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_via.c:2639]: parse_via(): end of header reached, state=5</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:555]: parse_headers(): Via found, flags=2</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:557]: parse_headers(): this is the first via</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [From] type 4</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [To] type 3</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=4088926SIPpTag014</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:173]: get_hdr_field(): <To> [63]; uri=[<a href="sip:service@192.168.1.15:5060" class="">sip:service@192.168.1.15:5060</a>]</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:176]: get_hdr_field(): to body (39)[service <<a href="sip:service@192.168.1.15:5060" class="">sip:service@192.168.1.15:5060</a>>], to tag (17)[4088926SIPpTag014]</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [Call-ID] type 6</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [CSeq] type 5</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/parser/msg_parser.c:154]: get_hdr_field(): cseq <CSeq>: <1> <ACK></font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: <core> [core/receive.c:387]: receive_msg(): --- received sip message - request - call-id: [<a href="mailto:1-1091869@192.168.1.12" class="">1-1091869@192.168.1.12</a>] - cseq: [1 ACK]</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/receive.c:259]: ksr_evrt_pre_routing(): event route core:pre-routing not defined</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/receive.c:457]: receive_msg(): preparing to run routing scripts...</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sl [sl_funcs.c:443]: sl_filter_ACK(): too late to be a local ACK!</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:489]: sr_lua_reload_script(): No need to reload [/etc/kamailio/kamailio.lua] is version 0</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:673]: app_lua_run_ex(): executing Lua function: [[ksr_request_route]]</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:675]: app_lua_run_ex(): lua top index is: 21</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [Contact] type 7</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [Max-Forwards] type 8</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [Subject] type 27</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [Content-Length] type 12</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/msg_parser.c:187]: get_hdr_field(): content_length=0</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/msg_parser.c:91]: get_hdr_field(): found end of header</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1007]: sr_kemi_lua_exec_func_ex(): param[0] for: process_maxfwd is int: 69</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: maxfwd [mf_funcs.c:74]: is_maxfwd_present(): value = 70</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1007]: sr_kemi_lua_exec_func_ex(): param[0] for: is_maxfwd_lt is int: 69</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: maxfwd [maxfwd.c:187]: ki_is_maxfwd_lt(): value = 69</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1007]: sr_kemi_lua_exec_func_ex(): param[0] for: sanity_check is int: 1511</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1007]: sr_kemi_lua_exec_func_ex(): param[1] for: sanity_check is int: 7</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:318]: check_required_headers(): check_required_headers entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:340]: check_required_headers(): check_required_headers passed</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:506]: check_cseq_method(): check_cseq_method entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:539]: check_cseq_method(): check_cseq_method passed</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:548]: check_cseq_value(): check_cseq_value entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:576]: check_cseq_value(): check_cseq_value passed</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:585]: check_cl(): check_cl entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:610]: check_cl(): check_cl passed</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:622]: check_expires_value(): check_expires_value entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:659]: check_expires_value(): no expires header found</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:759]: check_parse_uris(): check_parse_uris entered</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:763]: check_parse_uris(): parsing ruri</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:777]: check_parse_uris(): looking up From header</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:791]: check_parse_uris(): parsing From header</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/parse_addr_spec.c:185]: parse_to_param(): add param: tag=1091869SIPpTag001</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header reached, state=29</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:817]: check_parse_uris(): parsing From URI</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:835]: check_parse_uris(): looking up To header</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:857]: check_parse_uris(): check_parse_uris(): parsing To URI</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: sanity [sanity.c:902]: check_parse_uris(): check_parse_uris passed</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: siputils [checks.c:123]: has_totag(): totag found</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1003]: sr_kemi_lua_exec_func_ex(): param[0] for: dbg is str: EP: ksr_route_withindlg has to-tag, it is within a dialog</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/kemi.c:85]: sr_kemi_core_dbg(): EP: ksr_route_withindlg has to-tag, it is within a dialog</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: rr [loose.c:108]: find_first_route(): No Route headers found</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: rr [loose.c:1006]: loose_route_mode(): There is no Route HF</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: tm [t_lookup.c:1034]: t_check_msg(): msg (0x7fef983a2608) id=2/2414 global id=1/2414 T start=0xffffffffffffffff</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: tm [t_lookup.c:497]: t_lookup_request(): start searching: hash=12314, isACK=1</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: tm [t_lookup.c:455]: matching_3261(): RFC3261 transaction matching failed - via branch [z9hG4bK-1091869-1-5]</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: tm [t_lookup.c:675]: t_lookup_request(): no transaction found</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: tm [t_lookup.c:1103]: t_check_msg(): msg (0x7fef983a2608) id=2/2414 global id=2/2414 T end=(ni</font></div><div class=""><font face="Consolas" class="">l)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1003]: sr_kemi_lua_exec_func_ex(): param[0] for: dbg is str: EP: ksr_route_withindlg Unknown ACK exit</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/kemi.c:85]: sr_kemi_core_dbg(): EP: ksr_route_withindlg Unknown ACK exit</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1837]: sr_kemi_lua_exit(): script exit call</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:729]: app_lua_run_ex(): ksr error call from Lua: ~~ksr~exit~~</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_mod.c:167]: sr_kemi_config_engine_lua(): execution of route type 1 with no name returned 1</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: INFO: LUA {ACK}: <core> [core/receive.c:515]: receive_msg(): request-route executed in: 364 usec</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/xavp.c:541]: xavp_destroy_list(): destroying xavp list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/xavp.c:541]: xavp_destroy_list(): destroying xavp list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/xavp.c:541]: xavp_destroy_list(): destroying xavp list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/receive.c:606]: receive_msg(): cleaning up</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/udp_server.c:493]: udp_rcv_loop(): received on udp socket: (106/100/577) [[SIP/2.0 200 OK 0D  0A Via: SIP/2.0/UDP 192.168.1.15;branch=z9hG4bKa103.32dd17e8a1a3458280dbbe34442737e7.0,]]</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/parser/parse_fline.c:249]: parse_first_line(): first line type 2 (reply(status)) flags 1</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/parser/msg_parser.c:687]: parse_msg(): SIP Reply  (status):</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/parser/msg_parser.c:689]: parse_msg():  version: <SIP/2.0></font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/parser/msg_parser.c:691]: parse_msg():  status:  <200></font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/parser/msg_parser.c:693]: parse_msg():  reason:  <OK></font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/parser/parse_hname2.c:293]: parse_sip_header_name(): parsed header name [Via] type 1</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:37 ol-vm1 /usr/sbin/kamailio[2413]: DEBUG: <core> [core/parser/parse_via.c:1303]: parse_via_param(): Found param type 232, <branch> = <z9hG4bKa103.3</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: tm [t_lookup.c:1103]: t_check_msg(): msg (0x7fef983a2608) id=2/2414 global id=2/2414 T end=(nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1003]: sr_kemi_lua_exec_func_ex(): param[0] for: dbg is str: EP: ksr_route_withindlg Unknown ACK exit</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/kemi.c:85]: sr_kemi_core_dbg(): EP: ksr_route_withindlg Unknown ACK exit</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:1837]: sr_kemi_lua_exit(): script exit call</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_api.c:729]: app_lua_run_ex(): ksr error call from Lua: ~~ksr~exit~~</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: app_lua [app_lua_mod.c:167]: sr_kemi_config_engine_lua(): execution of route type 1 with no name returned 1</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: INFO: LUA {ACK}: <core> [core/receive.c:515]: receive_msg(): request-route executed in: 364 usec</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/usr_avp.c:637]: destroy_avp_list(): destroying list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/xavp.c:541]: xavp_destroy_list(): destroying xavp list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/xavp.c:541]: xavp_destroy_list(): destroying xavp list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/xavp.c:541]: xavp_destroy_list(): destroying xavp list (nil)</font></div><div class=""><font face="Consolas" class="">Nov 11 12:24:36 ol-vm1 /usr/sbin/kamailio[2414]: DEBUG: LUA {ACK}: <core> [core/receive.c:606]: receive_msg(): cleaning up</font></div></div><div class=""><br class=""></div><div class="">The ACK is this:</div><div class=""><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>ACK <a href="sip:service@192.168.1.15:5060" class="">sip:service@192.168.1.15:5060</a> SIP/2.0\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>Via: SIP/2.0/UDP 192.168.1.12:5060;branch=z9hG4bK-1091869-1-5\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>From: sipp <<a href="sip:sipp@192.168.1.12:5060" class="">sip:sipp@192.168.1.12:5060</a>>;tag=1091869SIPpTag001\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>To: service <<a href="sip:service@192.168.1.15:5060" class="">sip:service@192.168.1.15:5060</a>>;tag=4088926SIPpTag014\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>Call-ID:<span class="Apple-converted-space"> </span><a href="mailto:1-1091869@192.168.1.12" class="">1-1091869@192.168.1.12</a>\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>CSeq: 1 ACK\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>Contact: <a href="sip:sipp@192.168.1.12:5060\r\n" class="">sip:sipp@192.168.1.12:5060\r\n</a></font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>Max-Forwards: 70\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>Subject: Performance Test\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>Content-Length: 0\r\n</font></div><div class=""><font face="Consolas" class="">   <span class="Apple-converted-space"> </span>\r\n</font></div></div><div class=""><br class=""></div><div class="">I’ve been trying to figure this out for days and don’t know what’s wrong here.</div><div class=""><br class=""></div><div class="">Thanks</div></div></blockquote></div><span id="cid:C0AC2B6A-AA99-4AB4-B0C8-E52BEE66DC89@verizon.net"><PastedGraphic-2.png></span></div></div><br class=""></div></body></html>