Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE

partysip-dev
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]
Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE

From:	Aymeric Moizard
Subject:	Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE
Date:	Tue, 4 Feb 2003 22:43:32 +0100 (CET)

On Tue, 4 Feb 2003, [iso-8859-1] Kedar B. Patil wrote:

> Hi,
>
> I use partysip-0.5.3 as sip proxy.
>
> setup:
>
> (UA1, 192.168.51.229)-->(Proxy, 105.52.84.95)-->(UA2, 105.52.84.162)
>
>
> UA1 invites UA2, receives "180 Ringing" and then cancels the invite.
> Proxy does everything well, except that it returns "408 Request Timeout"
> to UA1 even after CANCEL, 200OK transaction is over.
>
> What am I missing here?

When a CANCEL is received partysip takes this action:
 send a new CANCEL to the same place where the INVITE was sent.
  (and do this only if a 1xx has been received!)
 wait for the final response for the INVITE.

As no answer is replied, we cannot not forward it so partysip
build a default answer.

Instead of this, partysip should receive a 487 Req Cancelled
and forward it correctly.

I don't think partysip should send a 487 itself.
Aymeric

> Also, a minor issue: Partysip produces following header with wrong version:
> user-agent: oSIP-ua/0.8.1
>
> thanks,
> = Kedar =
>
>
>
> ================  partysip log =====================================
>
>
> | INFO2 | <udp.c: 449> UDP MESSAGE RECEIVED
> | INFO2 | <udp.c: 483> udp plugin: RCV UDP MESSAGE (from 192.168.51.229:5060)
> | INFO1 | <udp.c: 491>
> INVITE sip:address@hidden SIP/2.0
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> Route: <sip:105.52.84.95;lr>
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Contact: <sip:address@hidden>
> max-forwards: 10
> user-agent: oSIP/Linphone-0.9.1
> Content-Type: application/sdp
> Content-Length: 361
>
> v=0
> o=kpatil 123456 654321 IN IP4 192.168.51.229
> s=A conversation
> c=IN IP4 192.168.51.229
> t=0 0
> m=audio 7078 RTP/AVP 3 115 8 0 110 111 101
> a=rtpmap:3 gsm/8000/1
> a=rtpmap:115 lpc10-1.5/8000/1
> a=rtpmap:8 PCMA/8000/1
> a=rtpmap:0 PCMU/8000/1
> a=rtpmap:110 speex-4/8000/1
> a=rtpmap:111 speex_lbr-4/8000/1
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-11
>
> | INFO2 | <transaction.c: 38> allocating transaction ressource 16 3448648908
> | INFO2 | <ist.c: 32> allocating IST context
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <psp_core4.c: 92> psp_core_cb_rcvinvite!
> | INFO1 | <udp.c: 674>
> SIP/2.0 100 Trying
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 179> psp_core_cb_snd1xx!
> | INFO2 | <imp.c: 260> imp module: wake up!
> | INFO1 | <psp_req.c: 32> Allocating psp_req ressource!
> | INFO2 | <syntax.c: 154> syntax plugin: Ip address detected!
> | INFO1 | <filter.c: 372> filter plugin: entering cb_filter_search_location
> | INFO1 | <filter.c: 484> filter plugin: Didn't do anything with this request?
> | INFO2 | <ls_sfull.c: 190> ls_sfull plugin: checking if we are responsible 
> for request-URI
> '105.52.84.162'
> | INFO1 | <ls_sfull.c: 233> ls_sfull plugin: mandate statefull handling for 
> route.
> | INFO2 | <sfp.c: 419> sfp module: wake up!
> | INFO2 | <osip_msg.c: 385> Checking if we are responsible for '105.52.84.95'
> | INFO2 | <transaction.c: 38> allocating transaction ressource 17 3448648908
> | INFO2 | <ict.c: 34> allocating ICT context
> | INFO2 | <sfp.c: 1125> sfp module: transaction correctly forwarded!
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <udp.c: 674>
> INVITE sip:address@hidden SIP/2.0
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Contact: <sip:address@hidden>
> max-forwards: 9
> user-agent: oSIP/Linphone-0.9.1
> Content-Type: application/sdp
> Content-Length: 361
>
> v=0
> o=kpatil 123456 654321 IN IP4 192.168.51.229
> s=A conversation
> c=IN IP4 192.168.51.229
> t=0 0
> m=audio 7078 RTP/AVP 3 115 8 0 110 111 101
> a=rtpmap:3 gsm/8000/1
> a=rtpmap:115 lpc10-1.5/8000/1
> a=rtpmap:8 PCMA/8000/1
> a=rtpmap:0 PCMU/8000/1
> a=rtpmap:110 speex-4/8000/1
> a=rtpmap:111 speex_lbr-4/8000/1
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-11
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 105.52.84.162 on port 5060
> | INFO1 | <psp_core5.c: 92> psp_core_cb_sndinvite!
> | INFO1 | <imp.c: 396> Swithing to sfull mode!
> | INFO1 | <udp.c: 674>
> INVITE sip:address@hidden SIP/2.0
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Contact: <sip:address@hidden>
> max-forwards: 9
> user-agent: oSIP/Linphone-0.9.1
> Content-Type: application/sdp
> Content-Length: 361
>
> v=0
> o=kpatil 123456 654321 IN IP4 192.168.51.229
> s=A conversation
> c=IN IP4 192.168.51.229
> t=0 0
> m=audio 7078 RTP/AVP 3 115 8 0 110 111 101
> a=rtpmap:3 gsm/8000/1
> a=rtpmap:115 lpc10-1.5/8000/1
> a=rtpmap:8 PCMA/8000/1
> a=rtpmap:0 PCMU/8000/1
> a=rtpmap:110 speex-4/8000/1
> a=rtpmap:111 speex_lbr-4/8000/1
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-11
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 105.52.84.162 on port 5060
> | INFO1 | <psp_core5.c: 76> psp_core_cb_sndreq_retransmission!
> | INFO2 | <udp.c: 449> UDP MESSAGE RECEIVED
> | INFO2 | <udp.c: 483> udp plugin: RCV UDP MESSAGE (from 105.52.84.162:5060)
> | INFO1 | <udp.c: 491>
> SIP/2.0 100 Trying
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO2 | <udp.c: 449> UDP MESSAGE RECEIVED
> | INFO2 | <udp.c: 483> udp plugin: RCV UDP MESSAGE (from 105.52.84.162:5060)
> | INFO1 | <udp.c: 491>
> SIP/2.0 180 Ringing
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>;tag=2011881815
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Contact: <sip:address@hidden:5060>
> Content-Length: 0
>
>
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <psp_core5.c: 164> psp_core_cb_rcv1xx!
> | INFO1 | <psp_core5.c: 164> psp_core_cb_rcv1xx!
> | INFO2 | <sfp.c: 419> sfp module: wake up!
> | INFO2 | <sfp.c: 1841> module sfp: 
> pspm_sfp_forward_provisionnal_final_response!
> | INFO1 | <udp.c: 674>
> SIP/2.0 180 Ringing
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>;tag=2011881815
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Contact: <sip:address@hidden:5060>
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 179> psp_core_cb_snd1xx!
> | INFO1 | <psp_core4.c: 68> psp_core_cb_nist_kill_transaction!
> | INFO1 | <uap.c: 330> uap module: delete a terminated context and its 
> transaction!
> | INFO2 | <transaction.c: 273> free transaction ressource 15 1511423342
> | INFO2 | <nist.c: 85> free nist ressource
> | INFO1 | <psp_req.c: 82> free psp_req ressouce!
> | INFO2 | <udp.c: 449> UDP MESSAGE RECEIVED
> | INFO2 | <udp.c: 483> udp plugin: RCV UDP MESSAGE (from 192.168.51.229:5060)
> | INFO1 | <udp.c: 491>
> CANCEL sip:address@hidden SIP/2.0
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> Route: <sip:105.52.84.95;lr>
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 CANCEL
> Contact: <sip:address@hidden>
> max-forwards: 10
> user-agent: oSIP/Linphone-0.9.1
> Content-Length: 0
>
>
> | INFO2 | <transaction.c: 38> allocating transaction ressource 18 3448648908
> | INFO2 | <nist.c: 32> allocating NIST context
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <psp_core4.c: 135> psp_core_cb_rcvcancel!
> | INFO2 | <sfp.c: 419> sfp module: wake up!
> | INFO2 | <sfp.c: 776> module sfp: Cancelling the request.!
> | INFO2 | <transaction.c: 38> allocating transaction ressource 19 3448648908
> | INFO2 | <nict.c: 34> allocating NICT context
> | INFO2 | <sfp.c: 1463> sfp module: Waiting for a final answer!
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <udp.c: 674>
> CANCEL sip:address@hidden SIP/2.0
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 CANCEL
> max-forwards: 70
> user-agent: oSIP-ua/0.8.1
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 105.52.84.162 on port 5060
> | INFO1 | <psp_core5.c: 116> psp_core_cb_sndcancel!
> | INFO1 | <udp.c: 674>
> SIP/2.0 200 OK
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 CANCEL
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 215> psp_core_cb_snd2xx!
> | INFO1 | <udp.c: 674>
> CANCEL sip:address@hidden SIP/2.0
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 CANCEL
> max-forwards: 70
> user-agent: oSIP-ua/0.8.1
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 105.52.84.162 on port 5060
> | INFO1 | <psp_core5.c: 76> psp_core_cb_sndreq_retransmission!
> | INFO2 | <udp.c: 449> UDP MESSAGE RECEIVED
> | INFO2 | <udp.c: 483> udp plugin: RCV UDP MESSAGE (from 105.52.84.162:5060)
> | INFO1 | <udp.c: 491>
> SIP/2.0 200 OK
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>;tag=2011881815
> Call-ID: address@hidden
> CSeq: 20 CANCEL
> Content-Length: 0
>
>
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <psp_core5.c: 174> psp_core_cb_rcv2xx!
> | INFO2 | <sfp.c: 419> sfp module: wake up!
> | INFO2 | <sfp.c: 1463> sfp module: Waiting for a final answer!
> | INFO2 | <sfp.c: 1463> sfp module: Waiting for a final answer!
> | INFO1 | <psp_core5.c: 60> psp_core_cb_nict_kill_transaction!
> | INFO2 | <sfp.c: 1463> sfp module: Waiting for a final answer!
> | INFO2 | <sfp.c: 1414> sfp module: answer request with code: 408!
> | INFO2 | <transaction.c: 38> allocating transaction ressource 20 3448648908
> | INFO2 | <nict.c: 34> allocating NICT context
> | ERROR | <sfp.c: 1434> module sfp: No valid location found; answer to 
> request with 480.!
> | INFO2 | <transaction.c: 273> free transaction ressource 19 3448648908
> | INFO2 | <nict.c: 115> free nict ressource
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <udp.c: 674>
> CANCEL sip:address@hidden SIP/2.0
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 CANCEL
> max-forwards: 70
> user-agent: oSIP-ua/0.8.1
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 105.52.84.162 on port 5060
> | INFO1 | <psp_core5.c: 116> psp_core_cb_sndcancel!
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 286> psp_core_cb_snd4xx!
> | INFO2 | <udp.c: 449> UDP MESSAGE RECEIVED
> | INFO2 | <udp.c: 483> udp plugin: RCV UDP MESSAGE (from 105.52.84.162:5060)
> | INFO1 | <udp.c: 491>
> SIP/2.0 200 OK
> Via: SIP/2.0/UDP 
> 105.52.84.95:5060;branch=z9hG4bKf0c06b1464acf623eaa7eac6b30323fdd.0
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>;tag=2011881815
> Call-ID: address@hidden
> CSeq: 20 CANCEL
> Content-Length: 0
>
>
> | INFO2 | <psp_osip.c: 70> osip module: wake up!
> | INFO1 | <psp_core5.c: 174> psp_core_cb_rcv2xx!
> | INFO2 | <sfp.c: 419> sfp module: wake up!
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 76> psp_core_cb_sndresp_retransmission!
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 76> psp_core_cb_sndresp_retransmission!
> | INFO1 | <psp_core5.c: 60> psp_core_cb_nict_kill_transaction!
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 76> psp_core_cb_sndresp_retransmission!
> | INFO2 | <transaction.c: 273> free transaction ressource 20 3448648908
> | INFO2 | <nict.c: 115> free nict ressource
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 76> psp_core_cb_sndresp_retransmission!
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 76> psp_core_cb_sndresp_retransmission!
> | INFO1 | <psp_core4.c: 68> psp_core_cb_nist_kill_transaction!
> | INFO2 | <transaction.c: 273> free transaction ressource 18 3448648908
> | INFO2 | <nist.c: 85> free nist ressource
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 76> psp_core_cb_sndresp_retransmission!
> | INFO1 | <udp.c: 674>
> SIP/2.0 408 Request Timeout
> Via: SIP/2.0/UDP 192.168.51.229:5060;branch=z9hG4bK2715066607
> From: <sip:address@hidden>;tag=493795869
> To: <sip:address@hidden>
> Call-ID: address@hidden
> CSeq: 20 INVITE
> Content-Length: 0
>
>
> | INFO1 | <udp.c: 745> udp_plugin: message sent to 192.168.51.229 on port 5060
> | INFO1 | <psp_core4.c: 76> psp_core_cb_sndresp_retransmission!
> | INFO1 | <psp_core4.c: 50> psp_core_cb_ist_kill_transaction!
>
> ====================================================================
>
>
> ________________________________________________________________________
> Missed your favourite TV serial last night? Try the new, Yahoo! TV.
>        visit http://in.tv.yahoo.com
>
>
> _______________________________________________
> Partysip-dev mailing list
> address@hidden
> http://mail.nongnu.org/mailman/listinfo/partysip-dev
>
[Prev in Thread]
Current Thread
[Next in Thread]
[Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE, Kedar B. Patil, 2003/02/04
- Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE, Aymeric Moizard <=
  - Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE, Gary Corcoran, 2003/02/04
    - Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE, Aymeric Moizard, 2003/02/05
Prev by Date: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE
Next by Date: Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE
Previous by thread: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE
Next by thread: Re: [Partysip-dev] '408 Request Timeout' response to CANCELLed INVITE
Index(es):
- Date
- Thread