New subject: in doubt about in-dialog INVITE Route params processing

4 Apr 2012


      I've been pondering an issue with Route header parameters being not
mirrored by kamailio proxy into Record-Route field on in-dialog requests
over the last few hours so I thought I'd just whether I'm missing
something obvious.
The call scenario in UA -> lb -> proxy -> sems. Everything is fine with
initial INVITE transaction where we add rr param ;rtpprx=yes. (We also
use dialog module.) The UA does re-INVITE where it mirrors RR headers to
Route set just fine. However, when forwarding re-INVITE kamailio proxy
removes own Route header and inserts RR header without rtpproxy, did etc
params.
The kamailio default config from branch 3.1 routes in-dialog requests in
the same fashion and I can't tell really if this is how it is supposed
to work? I can workaround this by add_rr_param() but shouldn't missing
did param cause a problem with dialog matching? Here is the debug with
log level 3:
...
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [loose.c:792]: Topmost route URI: 'sip:127.0.0.1:5062;lr;ftag=8pTM6oKWVtC4H03478xjIR34SSsYuTU5;did=8a3.aab32831;mpd=ii;rtpprx=yes;vsf=aDNlNDEjPSkBJB9/YykkNnYYdTZ0KGUsfGZxVndVe1M-' is me
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: <core> [parser/msg_parser.c:103]: found end of header
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [loose.c:257]: No next Route HF found
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [loose.c:811]: No next URI found
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [rr_cb.c:97]: callback id 1 entered with <lr;ftag=8pTM6oKWVtC4H03478xjIR34SSsYuTU5;did=8a3.aab32831;mpd=ii;rtpprx=yes;vsf=aDNlNDEjPSkBJB9/YykkNnYYdTZ0KGUsfGZxVndVe1M->
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: dialog [dlg_handlers.c:910]: route param is '8a3.aab32831' (len=12)
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: dialog [dlg_hash.c:442]: ref dlg 0x7f0a0be918b0 with 1 -> 3
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: dialog [dlg_hash.c:444]: dialog id=327302058 found on entry 936
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: dialog [dlg_hash.c:757]: dialog 0x7f0a0be918b0 changed from state 4 to state 4, due event 8
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: dialog [dlg_handlers.c:1042]: sequential request successfully processed
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: dialog [dlg_timer.c:117]: inserting 0x7f0a0be91900 for 127601858
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: dialog [dlg_hash.c:411]: cseq is 10760
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [rr_cb.c:97]: callback id 0 entered with <lr;ftag=8pTM6oKWVtC4H03478xjIR34SSsYuTU5;did=8a3.aab32831;mpd=ii;rtpprx=yes;vsf=aDNlNDEjPSkBJB9/YykkNnYYdTZ0KGUsfGZxVndVe1M->
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: uac [from.c:421]: getting 'vsf' Route param
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: uac [from.c:429]: route param is 'aDNlNDEjPSkBJB9/YykkNnYYdTZ0KGUsfGZxVndVe1M-' (len=44)
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: uac [from.c:479]: decoded uris are: new=[sip:43991001@192.168.51.210] old=[sip:sipwise-user1@192.168.51.210]
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [loose.c:983]: params are <;lr;ftag=8pTM6oKWVtC4H03478xjIR34SSsYuTU5;did=8a3.aab32831;mpd=ii;rtpprx=yes;vsf=aDNlNDEjPSkBJB9/YykkNnYYdTZ0KGUsfGZxVndVe1M->
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: siputils [checks.c:76]: totag found
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: textops [textops.c:1789]: content type is 196611
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [loose.c:983]: params are <;lr;ftag=8pTM6oKWVtC4H03478xjIR34SSsYuTU5;did=8a3.aab32831;mpd=ii;rtpprx=yes;vsf=aDNlNDEjPSkBJB9/YykkNnYYdTZ0KGUsfGZxVndVe1M->
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rr [loose.c:983]: params are <;lr;ftag=8pTM6oKWVtC4H03478xjIR34SSsYuTU5;did=8a3.aab32831;mpd=ii;rtpprx=yes;vsf=aDNlNDEjPSkBJB9/YykkNnYYdTZ0KGUsfGZxVndVe1M->
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: INFO: <script>: Use mediaproxy for forward direction for IPv4/IPv4 - M=INVITE R=sip:127.0.0.1:5080 F=sip:sipwise-user1@192.168.51.210 T=sip:43991002@192.168.51.210 IP=192.168.51.1:35189 (127.0.0.1:5060) ID=M6obxlxpUOPPR3CQYE-d2t9-fgybDo6y
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rtpproxy [rtpproxy_funcs.c:148]: type <application/sdp> found valid
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: DEBUG: rtpproxy [rtpproxy.c:2260]: proxy reply: 30080 192.168.51.210 4#012
Apr  4 13:23:21 sp1 /usr/sbin/kamailio[7520]: INFO: <script>: Relaying request - M=INVITE R=sip:127.0.0.1:5080 F=sip:sipwise-user1@192.168.51.210 T=sip:43991002@192.168.51.210 IP=192.168.51.1:35189 (127.0.0.1:5060) ID=M6obxlxpUOPPR3CQYE-d2t9-fgybDo6y