[SR-Users] Wrong dialog selected in on_reply/failure route in case of spirals.
Julia Boudniatsky
juliabo at gmail.com
Tue Dec 16 16:01:08 CET 2014
Hello Daniel,
Thank you for your reply.
We set module dialog with:
modparam("dialog", "detect_spirals", 1)
and
modparam("dialog", "dlg_match_mode", 1)
I analyze log and found that
"parse_to_param(): DEBUG: add_param: tag=" is missing in case of wrong
dialog allocation
correct dialog
===========
dialog:: hash=1561:6164
state:: 1
ref_count:: 1
timestart:: 0
timeout:: 0
callid:: 8-12006 at 10.25.153.150
from_uri:: sip:039988222 at 10.25.153.150;user=phone
from_tag:: 8
caller_contact:: sip:10.25.153.150:5062
caller_cseq:: 1
caller_route_set::
caller_bind_addr:: udp:10.25.153.150:5060
callee_bind_addr::
to_uri:: sip:D39539988200 at 10.25.153.150;user=phone
to_tag::
callee_contact::
callee_cseq::
callee_route_set::
dialog detected in 301
================
dialog:: hash=3838:6551
state:: 5
ref_count:: 1
timestart:: 1418731671
timeout:: 0
callid:: 7-12006 at 10.25.153.150
from_uri:: sip:039988222 at 10.25.153.150;user=phone
from_tag:: 7
caller_contact:: sip:10.25.153.150:5062
caller_cseq:: 1
caller_route_set::
caller_bind_addr:: udp:10.25.153.150:5060
callee_bind_addr:: udp:10.25.153.150:5060
to_uri:: sip:D39539988200 at 10.25.153.150;user=phone
to_tag:: 177
callee_contact:: sip:10.25.153.150:5061;transport=UDP
callee_cseq:: 0
callee_route_set::
<sip:10.25.154.104;lr;ftag=7;vst=AAAAAHQAAAwADw8MAHIBAG4DBQADAB0fBAYeCwAADUVIEAFYAlUfBgpuZQ-->,<sip:10.25.153.150;lr;ftag=7;vst=AAAAAHQAAAAADw8HDnYFCG4DBQADAB0fBAYeCwAADUVIEAFYAlUfBgpuZQ-->
Log debug3
receive1 INVITE
===========
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin//kamailio[5546]: DEBUG:
dialog [dlg_hash.c:720]: internal_get_dlg(): no dialog callid='
8-12006 at 10.25.153.150' found
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5546]: DEBUG:
dialog [dlg_hash.c:751]: get_dlg(): no dialog callid='8-12006 at 10.25.153.150'
found
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5546]: DEBUG:
dialog [dlg_handlers.c:1083]: dlg_get_msg_dialog(): dlg with callid '
8-12006 at 10.25.153.150' not found
dlg_manage();
==========
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5546]: DEBUG:
dialog [dlg_hash.c:654]: dlg_lookup(): ref dlg 0x7fb318d34fc8 with 1 -> 2
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5546]: DEBUG:
dialog [dlg_hash.c:656]: dlg_lookup(): dialog id=6164 found on entry 1561
send INVITE to Server 1
================
receive from Server 1 (spirals) INVITE
================
different "To" user - case of number translation
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5541]: DEBUG:
dialog [dlg_hash.c:654]: dlg_lookup(): ref dlg 0x7fb318d34fc8 with 1 -> 2
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5541]: DEBUG:
dialog [dlg_hash.c:656]: dlg_lookup(): dialog id=6164 found on entry 1561
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5541]: DEBUG:
dialog [dlg_profile.c:427]: set_current_dialog(): setting current dialog
[1561:6164]
send INVITE to Server 2
================
"To" = "To" in INVITE to Server 1
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5543]: DEBUG:
dialog [dlg_hash.c:711]: internal_get_dlg(): ref dlg 0x7fb318d34fc8 with 1
-> 2
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5543]: DEBUG:
dialog [dlg_hash.c:714]: internal_get_dlg(): dialog callid='
8-12006 at 10.25.153.150' found
on entry 1561, dir=1
100 from Server 1
============
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5541]: DEBUG:
dialog [dlg_hash.c:654]: dlg_lookup(): ref dlg 0x7fb318d34fc8 with 1 -> 3
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5541]: DEBUG:
dialog [dlg_hash.c:656]: dlg_lookup(): dialog id=6164 found on entry 1561
100 from Server 2
============
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5544]: DEBUG:
<core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
!!!!! Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5544]:
DEBUG: <core> [parser/parse_addr_spec.c:176]: parse_to_param(): DEBUG:
add_param: tag=8
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5544]: DEBUG:
<core> [parser/parse_addr_spec.c:898]: parse_addr_spec(): end of header
reached, state=29
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5544]: DEBUG:
dialog [dlg_hash.c:711]: internal_get_dlg(): ref dlg 0x7fb318d34fc8 with 1
-> 2
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5544]: DEBUG:
dialog [dlg_hash.c:714]: internal_get_dlg(): dialog callid='
8-12006 at 10.25.153.150' found
on entry 1561, dir=1
301 from Server 2
=============
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG:
<core> [receive.c:152]: receive_msg(): After parse_msg...
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG: tm
[t_lookup.c:1072]: t_check_msg(): DEBUG: t_check_msg: msg id=645 global
id=644 T start=0xffffffffffffffff
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG: tm
[t_lookup.c:949]: t_reply_matching(): DEBUG: t_reply_matching: hash 13904
label 0 branch 0
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG: tm
[t_lookup.c:1004]: t_reply_matching(): DEBUG: t_reply_matching: reply
matched (T=0x7fb318dcfae8)!
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG: tm
[t_lookup.c:1141]: t_check_msg(): DEBUG: t_check_msg: msg id=645 global
id=645 T end=0x7fb318dcfae8
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG: tm
[t_reply.c:2206]: reply_received(): DEBUG: reply_received: org. status
uas=100, uac[0]=100 local=0 is_invite=1)
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG:
<core> [parser/msg_parser.c:204]: get_hdr_field(): DEBUG: get_hdr_body :
content_length=0
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG:
<core> [parser/msg_parser.c:106]: get_hdr_field(): found end of header
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG:
dialog [dlg_hash.c:656]: dlg_lookup(): dialog id=6551 found on entry 3838
Dec 16 14:07:49 KAMnet-JAF-TST-01 /usr/local/sbin/kamailio[5540]: DEBUG:
dialog [dlg_hash.c:654]: dlg_lookup(): ref dlg 0x7fb318d989c0 with 1 -> 2
BR,
Julia
On Tue, Dec 16, 2014 at 1:03 PM, Daniel-Constantin Mierla <miconda at gmail.com
> wrote:
>
> Hello,
>
> looking again at your diagram, it seems that the Call-Id is the same, but
> there is a different dialog structure.
>
> If you dump the dialogs with kamctl, can you see the two structure listed?
> Are they with same dialog attributes (From/To/...)?
>
> Dialog module has a parameter for detecting spirals, have you set it to
> some value?
>
> Cheers,
> Daniel
>
> On 10/12/14 13:39, Julia Boudniatsky wrote:
>
> Hello Daniel,
>
> I have tried from latest git branch 4.1 (I see your new patches for
> dialog )
> But the problem steel occur.
>
> Thank you,
> Julia
>
>
> On Wed, Dec 10, 2014 at 12:21 PM, Daniel-Constantin Mierla <
> miconda at gmail.com> wrote:
>
>> Hello,
>>
>> can you try with latest git branch 4.1 and report the results? I just
>> pushed a patch that should fix it.
>>
>> Cheers,
>> Daniel
>>
>>
>> On 09/12/14 19:06, Julia Boudniatsky wrote:
>>
>> After kamailio upgrade from v3.3 to v4.1.7
>>
>> in production ~5% of calls with spirals dialog are failed with wrong
>> dialog variables in on-reply/failure routes.
>>
>>
>>
>> The problem has been reproduced in the LAB (load test generated by SIPP).
>>
>> Please see the attached file with debug3 log.
>>
>> Scenario:
>>
>> Proxy Location
>>
>> Kamailio P1 Nbr translation Redirect
>>
>> | INVITE | |
>>
>> | dlg 0x7f8f8501aba0 | |
>>
>> | Call-ID:(5-8286 at 10.25.153.150) | |
>>
>> |------------------------------->| |
>>
>> | 100 Trying | |
>>
>> | dlg 0x7f8f8501aba0 | |
>>
>> | Call-ID:(5-8286 at 10.25.153.150) | |
>>
>> |<-------------------------------| |
>>
>> | | |
>>
>> | INVITE | |
>>
>> | dlg 0x7f8f8501aba0 | |
>>
>> | Call-ID:(5-8286 at 10.25.153.150) | |
>>
>> |<-------------------------------| |
>>
>> | 100 Trying | |
>>
>> | dlg 0x7f8f8501aba0 | |
>>
>> | Call-ID:(5-8286 at 10.25.153.150) | |
>>
>> |------------------------------->| |
>>
>> | | |
>>
>> | INVITE | |
>>
>> | dlg 0x7f8f8501aba0 | |
>>
>> | Call-ID:(5-8286 at 10.25.153.150) |
>>
>>
>> |-------------------------------------------------------------->|
>>
>> | 100 Trying |
>>
>> | dlg 0x7f8f8504cda0 !!!!!!!! |
>>
>> | Call-ID:(5-8286 at 10.25.153.150)|
>>
>> |<--------------------------------------------------------------|
>>
>> | 301 Moved Permanently |
>>
>> | dlg 0x7f8f8504cda0 !!!!!!!! |
>>
>> | Call-ID:(5-8286 at 10.25.153.150)|
>>
>>
>> |<--------------------------------------------------------------|
>>
>>
>> | |
>>
>>
>>
>> Thank you,
>>
>> Julia.
>>
>>
>> _______________________________________________
>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing listsr-users at lists.sip-router.orghttp://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>
>>
>> --
>> Daniel-Constantin Mierlahttp://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
>>
>>
>> _______________________________________________
>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>> sr-users at lists.sip-router.org
>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>
>>
>
> --
> Daniel-Constantin Mierlahttp://twitter.com/#!/miconda - http://www.linkedin.com/in/miconda
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.sip-router.org/pipermail/sr-users/attachments/20141216/fb6e1e41/attachment.html>
More information about the sr-users
mailing list