Hello,
can you send the SIP traffic of such call in a pcap file? It makes it
easier to investigate with sngrep/wireshark instead of trying to read
through text output of the SIP traffic that you pasted in the first email.
Cheers,
Daniel
On 12.08.20 11:05, Techinnovation wrote:
Re: [SR-Users] ACK no transaction found if re-invite
Hello Daniel !
I add record_route(). Still have same result .
now my config is :
route[WITHINDLG] {
if (has_totag()) {
record_route();
# sequential request withing a dialog should
# take the path determined by record-routing
if (loose_route()) {
if (is_method("BYE")) {
setflag(FLT_ACC); # do accounting ...
setflag(FLT_ACCFAILED); # ... even if
the transaction fails
}
route(RELAY);
}
else {
if (is_method("SUBSCRIBE") && uri == myself) {
# in-dialog subscribe requests
route(PRESENCE);
exit;
}
if ( is_method("ACK") ) {
if ( t_check_trans() ) {
# non loose-route, but stateful
ACK;
# must be ACK after a 487 or
e.g. 404 from upstream server
t_relay();
exit;
} else {
# ACK without matching
transaction ... ignore and discard.
exit;
}
}
t_relay();
}
exit;
}
}
kamailio log
[4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060] - cseq:
[18259129 ACK]
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: <core>
[core/parser/msg_parser.c:185]: get_hdr_field(): content_length=0
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: <core>
[core/parser/msg_parser.c:89]: get_hdr_field(): found end of header
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/receive.c:296]: receive_msg(): preparing to run routing scripts...
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sl
[sl_funcs.c:397]: sl_filter_ACK(): too late to be a local ACK!
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} maxfwd
[mf_funcs.c:74]: is_maxfwd_present(): value = 70
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:247]: check_ruri_sip_version(): check_ruri_sip_version entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:270]: check_ruri_sip_version(): check_ruri_sip_version passed
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:277]: check_ruri_scheme(): check_ruri_scheme entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:297]: check_ruri_scheme(): check_ruri_scheme passed
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:305]: check_required_headers(): check_required_headers entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:313]: check_required_headers(): check_required_headers passed
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:479]: check_cseq_method(): check_cseq_method entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:512]: check_cseq_method(): check_cseq_method passed
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:521]: check_cseq_value(): check_cseq_value entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:549]: check_cseq_value(): check_cseq_value passed
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:558]: check_cl(): check_cl entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:583]: check_cl(): check_cl passed
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:595]: check_expires_value(): check_expires_value entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:632]: check_expires_value(): no expires header found
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:732]: check_parse_uris(): check_parse_uris entered
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:736]: check_parse_uris(): parsing ruri
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:750]: check_parse_uris(): looking up From header
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:764]: check_parse_uris(): parsing From header
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/parser/parse_addr_spec.c:185]: parse_to_param(): add param:
tag=00-07198-01aa7c42-632e1ccc6
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/parser/parse_addr_spec.c:864]: parse_addr_spec(): end of header
reached, state=29
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:790]: check_parse_uris(): parsing From URI
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:808]: check_parse_uris(): looking up To header
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:830]: check_parse_uris(): check_parse_uris(): parsing To URI
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity.c:875]: check_parse_uris(): check_parse_uris passed
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} sanity
[sanity_mod.c:254]: w_sanity_check(): sanity checks result: 1
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} siputils
[checks.c:123]: has_totag(): totag found
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} rr
[record.c:475]: record_route(): inserted record route (r2: 1 - plen: 0)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} rr
[loose.c:114]: find_first_route(): No Route headers found
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} rr
[loose.c:961]: loose_route(): There is no Route HF
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} tm
[t_lookup.c:1043]: t_check_msg(): msg (0x7fe00b433288) id=20/28987
global id=19/28987 T start=(nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} tm
[t_lookup.c:500]: t_lookup_request(): start searching: hash=30828, isACK=1
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} tm
[t_lookup.c:458]: matching_3261(): RFC3261 transaction matching failed
- via branch [z9hG4bK-4F08643B-1884F5D]
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} tm
[t_lookup.c:682]: t_lookup_request(): no transaction found
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} tm
[t_lookup.c:1113]: t_check_msg(): msg (0x7fe00b433288) id=20/28987
global id=20/28987 T end=(nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/receive.c:354]: receive_msg(): request-route executed in: 158 usec
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/usr_avp.c:636]: destroy_avp_list(): destroying list (nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/xavp.c:507]: xavp_destroy_list(): destroying xavp list (nil)
Aug 12 11:57:48 c4-proxy-1 kamailio: 21(28987) DEBUG: {1 18259129 ACK
4fdf3fe8321fc64667329489142bc36f@48.146.161.152:5060} <core>
[core/receive.c:458]: receive_msg(): cleaning up
[...]
/--
Best regards,
Techinnovation
/mailto:techinnovation@inbox.lv
--
Daniel-Constantin Mierla --
www.asipto.com
www.twitter.com/miconda --
www.linkedin.com/in/miconda
Funding:
https://www.paypal.me/dcmierla