29 Jun
2006
29 Jun
'06
2:39 p.m.
Bogdan-Andrei Iancu wrote:
Hi,
as you can seem the incoming BYE has no Route header. This leads to
these cases:
1) you do not do record_route - check the outgoing INVITE to see if
your RR hdr is present
yes is present
2) the RR set is not properly mirrored in the 200
OK (again, check
the 200 OK reply)
yes there is
3) the UA that generates the BYE does not use the
RR set (which is
bogus)
yes. the call to PSTN pass for a softswitch. i contact the vendor. thanks
I've also tried with call UA --> UA that pass only from proxy and there
is the same problem on accounting.
To/From not swapped ,if the callee hangup phone, before send accounting
and yes there is RR present in the BYE message.
you can find attached here the full dump.
UA1 - 82.215.128.140
UA2 - 82.215.128.141
PROXY - 82.215.130.161
3(38040) udp_rcv_loop: probing packet received from 82.215.128.140 50195
3(38040) SIP Request:
3(38040) method: <BYE>
3(38040) uri: <sip:396006660009@82.215.128.140>
3(38040) version: <SIP/2.0>
3(38040) parse_headers: flags=2
3(38040) Found param type 232, <branch> = <z9hG4bK2b3078b2d0c5e3bd>;
state=16
3(38040) end of header reached, state=5
3(38040) parse_headers: Via found, flags=2
3(38040) parse_headers: this is the first via
3(38040) After parse_msg...
3(38040) preparing to run routing scripts...
3(38040) parse_headers: flags=100
3(38040) DEBUG: add_param: tag=bdb21d1b47a3e954
3(38040) DEBUG:parse_to:end of header reached, state=29
3(38040) DBUG:parse_to: display={"0104491009"},
ruri={sip:0104491009@dispatcher.plexia.com}
3(38040) DEBUG: get_hdr_field: <To> [74];
uri=[sip:0104491009@dispatcher.plexia.com]
3(38040) DEBUG: to body ["0104491009"
<sip:0104491009@dispatcher.plexia.com>]
3(38040) get_hdr_field: cseq <CSeq>: <201> <BYE>
3(38040) DEBUG:maxfwd:is_maxfwd_present: value = 70
3(38040) DEBUG: add_param: tag=5539c21944091059
3(38040) DEBUG:parse_to:end of header reached, state=29
3(38040) DBUG:parse_to: display={},
ruri={sip:0104491002@dispatcher.plexia.com}
3(38040) DEBUG:avpops:dbstore_avps: 1 avps were stored
3(38040) DEBUG:avpops:dbstore_avps: 1 avps were stored
3(38040) RETURN CODE: <null> <null>
3(38040) avpops:ops_dbquery_avps: query [select value from
usr_preferences where uuid='895e6709217a9c5c(a)82.215.128.140' and
attribute='setup_time']
3(38040) avpops:ops_dbquery_avps: query [select value from
usr_preferences where uuid='895e6709217a9c5c(a)82.215.128.140' and
attribute='connect_time']
3(38040) avpops:ops_dbquery_avps: query [select value from
usr_preferences where uuid='895e6709217a9c5c(a)82.215.128.140' and
attribute='disconnect_time']
3(38040) db_flags=3, flags=4
3(38040) DEBUG:avpops:load_avps: loaded avps = 1
3(38040) parse_headers: flags=200
3(38040) is_preloaded: No
3(38040) grep_sock_info - checking if host==us: 14==14 &&
[82.215.128.140] == [82.215.130.161]
3(38040) grep_sock_info - checking if port 5060 matches port 5060
3(38040) grep_sock_info - checking if host==us: 14==9 &&
[82.215.128.140] == [127.0.0.1]
3(38040) grep_sock_info - checking if port 5060 matches port 5060
3(38040) grep_sock_info - checking if host==us: 14==14 &&
[82.215.128.140] == [82.215.130.161]
3(38040) grep_sock_info - checking if port 5060 matches port 5060
3(38040) grep_sock_info - checking if host==us: 14==9 &&
[82.215.128.140] == [127.0.0.1]
3(38040) grep_sock_info - checking if port 5060 matches port 5060
3(38040) check_self: host != me
3(38040) grep_sock_info - checking if host==us: 14==14 &&
[82.215.130.161] == [82.215.130.161]
3(38040) grep_sock_info - checking if port 5060 matches port 5060
3(38040) after_loose: Topmost route URI:
'sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20-'
is me
3(38040) parse_headers: flags=200
3(38040) DEBUG: get_hdr_body : content_length=0
3(38040) found end of header
3(38040) find_next_route: No next Route HF found
3(38040) after_loose: No next URI found
3(38040) DBG:rr:run_rr_callbacks: callback id 0 entered
3(38040) DEBUG:uac:restore_from: getting 'vsf' Route param
3(38040) DEBUG:uac:restore_from: Route param is
'AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20-' (len=52)
3(38040) DEBUG:uac:restore_from: decoded uris are:
new=[sip:396006660009@dispatcher.plexia.com]
old=[sip:0104491009@dispatcher.plexia.com]
3(38040) DEBUG: t_check: msg id=2 global id=1 T start=0xffffffff
3(38040) parse_headers: flags=ffffffffffffffff
3(38040) parse_headers: flags=78
3(38040) t_lookup_request: start searching: hash=16278, isACK=0
3(38040) DEBUG: RFC3261 transaction matching failed
3(38040) DEBUG: t_lookup_request: no transaction found
3(38040) DEBUG: t_check: msg id=2 global id=2 T end=0x0
3(38040) parse_headers: flags=ffffffffffffffff
3(38040) DEBUG: t_newtran: msg id=2 , global msg id=2 , T on entrance=0x0
3(38040) parse_headers: flags=ffffffffffffffff
3(38040) parse_headers: flags=78
3(38040) t_lookup_request: start searching: hash=16278, isACK=0
3(38040) DEBUG: RFC3261 transaction matching failed
3(38040) DEBUG: t_lookup_request: no transaction found
3(38040) DBG: trans=0x28523c48, callback type 1, id 0 entered
3(38040) parse_headers: flags=58
3(38040) DEBUG: mk_proxy: doing DNS lookup...
3(38040) check_via_address(82.215.128.141, 82.215.128.141, 0)
3(38040) DEBUG: add_to_tail_of_timer[4]: 0x28523d64
3(38040) DEBUG: add_to_tail_of_timer[0]: 0x28523d74
3(38040) SER: new transaction fwd'ed
3(38040) DEBUG:tm:UNREF_UNSAFE: after is 0
3(38040) DEBUG:destroy_avp_list: destroying list 0x0
3(38040) receive_msg: cleaning up
4(38041) SIP Reply (status):
4(38041) version: <SIP/2.0>
4(38041) status: <200>
4(38041) reason: <OK>
#
U 82.215.128.140:5060 -> 82.215.130.161:5060
INVITE sip:0104491002@dispatcher.plexia.com SIP/2.0.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
From: "396006660009"
<sip:396006660009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>.
Contact: <sip:396006660009@82.215.128.140>.
Supported: replaces.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
User-Agent: Grandstream HT286 1.0.6.7.
Max-Forwards: 70.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Type: application/sdp.
Content-Length: 371.
.
v=0.
o=396006660009 8000 8000 IN IP4 82.215.128.140.
s=SIP Call.
c=IN IP4 82.215.128.140.
t=0 0.
m=audio 5004 RTP/AVP 18 0 4 2 15 98 101.
a=sendrecv.
a=rtpmap:18 G729/8000.
a=rtpmap:0 PCMU/8000.
a=rtpmap:4 G723/8000.
a=rtpmap:2 G726-32/8000.
a=rtpmap:15 G728/8000.
a=rtpmap:98 iLBC/8000.
a=fmtp:98 mode=20.
a=ptime:20.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-11.
#
U 82.215.130.161:5060 -> 82.215.128.140:5060
SIP/2.0 100 trying -- your call is important to us.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
From: "396006660009"
<sip:396006660009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
Server: OpenSer (1.1.0-pre2-notls (i386/freebsd)).
Content-Length: 0.
Warning: 392 82.215.130.161:5060 "Noisy feedback tells: pid=38039
req_src_ip=82.215.128.140 req_src_port=5060 in_uri=sip:0104491002@dispatcher.plexia.com
out_uri=sip:396006660002@82.215.128.141 via_cnt==1".
.
#
U 82.215.130.161:5060 -> 82.215.128.141:5060
INVITE sip:396006660002@82.215.128.141 SIP/2.0.
Record-Route:
<sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20->.
Via: SIP/2.0/UDP 82.215.130.161;branch=z9hG4bK42bc.fa208bf5.0.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
From: "0104491009"
<sip:0104491009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>.
Contact: <sip:396006660009@82.215.128.140>.
Supported: replaces.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
User-Agent: Grandstream HT286 1.0.6.7.
Max-Forwards: 69.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Type: application/sdp.
Content-Length: 371.
.
v=0.
o=396006660009 8000 8000 IN IP4 82.215.128.140.
s=SIP Call.
c=IN IP4 82.215.128.140.
t=0 0.
m=audio 5004 RTP/AVP 18 0 4 2 15 98 101.
a=sendrecv.
a=rtpmap:18 G729/8000.
a=rtpmap:0 PCMU/8000.
a=rtpmap:4 G723/8000.
a=rtpmap:2 G726-32/8000.
a=rtpmap:15 G728/8000.
a=rtpmap:98 iLBC/8000.
a=fmtp:98 mode=20.
a=ptime:20.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-11.
#
U 82.215.128.141:5060 -> 82.215.130.161:5060
SIP/2.0 100 Trying.
Via: SIP/2.0/UDP 82.215.130.161;branch=z9hG4bK42bc.fa208bf5.0.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
From: "0104491009"
<sip:0104491009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
User-Agent: Grandstream HT286 1.0.6.7.
Content-Length: 0.
.
#
U 82.215.128.141:5060 -> 82.215.130.161:5060
SIP/2.0 180 Ringing.
Via: SIP/2.0/UDP 82.215.130.161;branch=z9hG4bK42bc.fa208bf5.0.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
Record-Route:
<sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20->.
From: "0104491009"
<sip:0104491009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
User-Agent: Grandstream HT286 1.0.6.7.
Content-Length: 0.
.
#
U 82.215.130.161:5060 -> 82.215.128.140:5060
SIP/2.0 180 Ringing.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
Record-Route:
<sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20->.
From: "396006660009"
<sip:396006660009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
User-Agent: Grandstream HT286 1.0.6.7.
Content-Length: 0.
.
#
U 82.215.128.141:5060 -> 82.215.130.161:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP 82.215.130.161;branch=z9hG4bK42bc.fa208bf5.0.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
Record-Route:
<sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20->.
From: "0104491009"
<sip:0104491009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
User-Agent: Grandstream HT286 1.0.6.7.
Contact: <sip:396006660002@82.215.128.141>.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Type: application/sdp.
Supported: replaces.
Content-Length: 225.
.
v=0.
o=396006660002 8000 8000 IN IP4 82.215.128.141.
s=SIP Call.
c=IN IP4 82.215.128.141.
t=0 0.
m=audio 5004 RTP/AVP 18 101.
a=sendrecv.
a=rtpmap:18 G729/8000.
a=ptime:20.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-11.
#
U 82.215.130.161:5060 -> 82.215.128.140:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bK51821efdeb8b7bf6.
Record-Route:
<sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20->.
From: "396006660009"
<sip:396006660009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 INVITE.
User-Agent: Grandstream HT286 1.0.6.7.
Contact: <sip:396006660002@82.215.128.141>.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Type: application/sdp.
Supported: replaces.
Content-Length: 225.
.
v=0.
o=396006660002 8000 8000 IN IP4 82.215.128.141.
s=SIP Call.
c=IN IP4 82.215.128.141.
t=0 0.
m=audio 5004 RTP/AVP 18 101.
a=sendrecv.
a=rtpmap:18 G729/8000.
a=ptime:20.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-11.
#
U 82.215.128.140:5060 -> 82.215.130.161:5060
ACK sip:396006660002@82.215.128.141 SIP/2.0.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bKbb42b55628a978bd.
Route:
<sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20->.
From: "396006660009"
<sip:396006660009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
Contact: <sip:396006660009@82.215.128.140>.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 ACK.
User-Agent: Grandstream HT286 1.0.6.7.
Max-Forwards: 70.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Length: 0.
.
#
U 82.215.130.161:5060 -> 82.215.128.141:5060
ACK sip:396006660002@82.215.128.141 SIP/2.0.
Record-Route: <sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954>.
Via: SIP/2.0/UDP 82.215.130.161;branch=z9hG4bK42bc.fa208bf5.2.
Via: SIP/2.0/UDP 82.215.128.140;branch=z9hG4bKbb42b55628a978bd.
From: "396006660009"
<sip:0104491009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
To: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
Contact: <sip:396006660009@82.215.128.140>.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 34276 ACK.
User-Agent: Grandstream HT286 1.0.6.7.
Max-Forwards: 69.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Length: 0.
P-hint: rr-enforced.
.
#
U 82.215.128.140:5060 -> 82.215.130.161:5060
....
#
U 82.215.128.141:5060 -> 82.215.130.161:5060
BYE sip:396006660009@82.215.128.140 SIP/2.0.
Via: SIP/2.0/UDP 82.215.128.141;branch=z9hG4bK2b3078b2d0c5e3bd.
Route:
<sip:82.215.130.161;lr=on;ftag=bdb21d1b47a3e954;vsf=AAAAAAMIBgQEDwcGAAlwXSkXGRIEAhwGGksCQhUUDBlHAkEOb20->.
From: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
To: "0104491009"
<sip:0104491009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 201 BYE.
User-Agent: Grandstream HT286 1.0.6.7.
Max-Forwards: 70.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Length: 0.
.
#
U 82.215.130.161:5060 -> 82.215.128.140:5060
BYE sip:396006660009@82.215.128.140 SIP/2.0.
Record-Route: <sip:82.215.130.161;lr=on;ftag=5539c21944091059>.
Via: SIP/2.0/UDP 82.215.130.161;branch=z9hG4bK69f3.adfb9657.0.
Via: SIP/2.0/UDP 82.215.128.141;branch=z9hG4bK2b3078b2d0c5e3bd.
From: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
To: "0104491009"
<sip:396006660009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 201 BYE.
User-Agent: Grandstream HT286 1.0.6.7.
Max-Forwards: 69.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Content-Length: 0.
P-hint: rr-enforced.
.
#
U 82.215.128.140:5060 -> 82.215.130.161:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP 82.215.130.161;branch=z9hG4bK69f3.adfb9657.0.
Via: SIP/2.0/UDP 82.215.128.141;branch=z9hG4bK2b3078b2d0c5e3bd.
Record-Route: <sip:82.215.130.161;lr=on;ftag=5539c21944091059>.
From: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
To: "0104491009"
<sip:396006660009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 201 BYE.
User-Agent: Grandstream HT286 1.0.6.7.
Contact: <sip:396006660009@82.215.128.140>.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Supported: replaces.
Content-Length: 0.
.
#
U 82.215.130.161:5060 -> 82.215.128.141:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP 82.215.128.141;branch=z9hG4bK2b3078b2d0c5e3bd.
Record-Route: <sip:82.215.130.161;lr=on;ftag=5539c21944091059>.
From: <sip:0104491002@dispatcher.plexia.com>;tag=5539c21944091059.
To: "0104491009"
<sip:0104491009@dispatcher.plexia.com>;tag=bdb21d1b47a3e954.
Call-ID: 895e6709217a9c5c(a)82.215.128.140.
CSeq: 201 BYE.
User-Agent: Grandstream HT286 1.0.6.7.
Contact: <sip:396006660009@82.215.128.140>.
Allow: INVITE,ACK,CANCEL,BYE,NOTIFY,REFER,OPTIONS,INFO,SUBSCRIBE.
Supported: replaces.
Content-Length: 0.
.
#