[Freeswitch-users] sip cancel request fails
Steven Ward
steve.d.ward at gmail.com
Tue Mar 24 08:06:15 PDT 2009
Mike,
Thanks for taking the time to look at this - I appreciate it. I'll go ahead
and test it out on the current svn trunk.
- Steve
2009/3/24 Michael Jerris <mike at jerris.com>
> This appears to be a bug in FreeSWITCH. Can you please test this on
> current svn trunk and if it is still a problem, please report this as a bug
> to http://jira.freeswitch.org.
> MIke
>
> On Mar 24, 2009, at 10:54 AM, Michael Jerris wrote:
>
> I note that its missing the to tag from the 180 sent 5 seconds earlier (I
> think thats okay) but the via branch tag is also different, which seems
> wrong. Can anyone else chime in, I can't recall the dialog matching rules
> of early dialog like this.
> Mike
>
> On Mar 24, 2009, at 9:57 AM, Steven Ward wrote:
>
> Here it is:
>
> freeswitch at b-pbx-lab-1> recv 517 bytes from udp/[10.1.21.44]:5060 at
> 13:53:07.644865:
> ------------------------------------------------------------------------
> OPTIONS sip:b-pbx-lab-1.mynet.net SIP/2.0
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK1b372b8d;rport
> From: "Unknown" <sip:Unknown at 10.1.21.44 <sip%3AUnknown at 10.1.21.44>
> >;tag=as5adee8f4
> To: <sip:b-pbx-lab-1.mynet.net>
> Contact: <sip:Unknown at 10.1.21.44 <sip%3AUnknown at 10.1.21.44>>
> Call-ID: 2e6222b16df27200056f742a070f0b56 at 10.1.21.44
> CSeq: 102 OPTIONS
> User-Agent: Asterisk PBX
> Max-Forwards: 70
> Date: Tue, 24 Mar 2009 13:53:07 GMT
> Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
> Supported: replaces
> Content-Length: 0
> ------------------------------------------------------------------------
> send 694 bytes to udp/[10.1.21.44]:5060 at 13:53:07.646132:
> ------------------------------------------------------------------------
> SIP/2.0 200 OK
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK1b372b8d;rport=5060
> From: "Unknown" <sip:Unknown at 10.1.21.44 <sip%3AUnknown at 10.1.21.44>
> >;tag=as5adee8f4
> To: <sip:b-pbx-lab-1.mynet.net>;tag=DytraHp3K84aD
> Call-ID: 2e6222b16df27200056f742a070f0b56 at 10.1.21.44
> CSeq: 102 OPTIONS
> Contact: <sip:10.1.21.45>
> User-Agent: FreeSWITCH-mod_sofia/1.0.3-exported
> Accept: application/sdp
> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
> NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
> Supported: 100rel, timer, precondition, path, replaces
> Allow-Events: talk, presence, dialog, call-info, sla,
> include-session-description, presence.winfo, message-summary, refer
> Content-Length: 0
> ------------------------------------------------------------------------
> recv 812 bytes from udp/[10.1.21.44]:5060 at 13:53:11.661169:
> ------------------------------------------------------------------------
> INVITE sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>SIP/2.0
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK0231224c;rport
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >
> Contact: <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>>
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 102 INVITE
> User-Agent: Asterisk PBX
> Max-Forwards: 70
> Date: Tue, 24 Mar 2009 13:53:11 GMT
> Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
> Supported: replaces
> Content-Type: application/sdp
> Content-Length: 258
> v=0
> o=root 4756 4756 IN IP4 10.1.21.44
> s=session
> c=IN IP4 10.1.21.44
> t=0 0
> m=audio 17956 RTP/AVP 0 8 101
> a=rtpmap:0 PCMU/8000
> a=rtpmap:8 PCMA/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=silenceSupp:off - - - -
> a=ptime:20
> a=sendrecv
> ------------------------------------------------------------------------
> send 333 bytes to udp/[10.1.21.44]:5060 at 13:53:11.662467:
> ------------------------------------------------------------------------
> SIP/2.0 100 Trying
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK0231224c;rport=5060
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 102 INVITE
> User-Agent: FreeSWITCH-mod_sofia/1.0.3-exported
> Content-Length: 0
> ------------------------------------------------------------------------
> send 815 bytes to udp/[10.1.21.44]:5060 at 13:53:11.682660:
> ------------------------------------------------------------------------
> SIP/2.0 407 Proxy Authentication Required
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK0231224c;rport=5060
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >;tag=e7KHcc76gHUXr
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 102 INVITE
> User-Agent: FreeSWITCH-mod_sofia/1.0.3-exported
> Accept: application/sdp
> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
> NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
> Supported: 100rel, timer, precondition, path, replaces
> Allow-Events: talk, presence, dialog, call-info, sla,
> include-session-description, presence.winfo, message-summary, refer
> Proxy-Authenticate: Digest realm="10.1.21.44",
> nonce="1d23f0ec-187b-11de-8c60-ad87768304bc", algorithm=MD5, qop="auth"
> Content-Length: 0
> ------------------------------------------------------------------------
> recv 407 bytes from udp/[10.1.21.44]:5060 at 13:53:11.684103:
> ------------------------------------------------------------------------
> ACK sip:70904 at b-pbx-lab-1.mynet.net <sip%3A70904 at b-pbx-lab-1.mynet.net>SIP/2.0
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK0231224c;rport
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >;tag=e7KHcc76gHUXr
> Contact: <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>>
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 102 ACK
> User-Agent: Asterisk PBX
> Max-Forwards: 70
> Content-Length: 0
> ------------------------------------------------------------------------
> recv 1089 bytes from udp/[10.1.21.44]:5060 at 13:53:11.685306:
> ------------------------------------------------------------------------
> INVITE sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>SIP/2.0
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK7858c13c;rport
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >
> Contact: <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>>
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 103 INVITE
> User-Agent: Asterisk PBX
> Max-Forwards: 70
> Proxy-Authorization: Digest username="b-pbx-lab-1", realm="10.1.21.44",
> algorithm=MD5, uri="sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>",
> nonce="1d23f0ec-187b-11de-8c60-ad87768304bc",
> response="f632ad9dd89f761cbfa442d7ed9c5556", qop=auth, cnonce="0e89cc90",
> nc=00000001
> Date: Tue, 24 Mar 2009 13:53:11 GMT
> Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
> Supported: replaces
> Content-Type: application/sdp
> Content-Length: 258
> v=0
> o=root 4756 4757 IN IP4 10.1.21.44
> s=session
> c=IN IP4 10.1.21.44
> t=0 0
> m=audio 17956 RTP/AVP 0 8 101
> a=rtpmap:0 PCMU/8000
> a=rtpmap:8 PCMA/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=silenceSupp:off - - - -
> a=ptime:20
> a=sendrecv
> ------------------------------------------------------------------------
> send 333 bytes to udp/[10.1.21.44]:5060 at 13:53:11.686526:
> ------------------------------------------------------------------------
> SIP/2.0 100 Trying
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK7858c13c;rport=5060
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 103 INVITE
> User-Agent: FreeSWITCH-mod_sofia/1.0.3-exported
> Content-Length: 0
> ------------------------------------------------------------------------
> 2009-03-24 09:53:11 [NOTICE] switch_channel.c:567 switch_channel_set_name()
> New Channel sofia/internal/70904 at 10.1.21.44[1d28557e-187b-11de-8c60-ad87768304bc]
> 2009-03-24 09:53:11 [INFO] mod_dialplan_xml.c:233 dialplan_hunt()
> Processing Steve->70904 in context default
> 2009-03-24 09:53:11 [NOTICE] switch_channel.c:567 switch_channel_set_name()
> New Channel sofia/internal/
> sip:70904 at 10.1.56.106:44952;rinstance=481ff1bdc7ab2a4c;fs_nat=yes[1d3a376c-187b-11de-8c60-ad87768304bc]
> send 1212 bytes to udp/[10.1.56.106]:44952 at 13:53:11.814291:
> ------------------------------------------------------------------------
> INVITE sip:70904 at 10.1.56.106:44952;rinstance=481ff1bdc7ab2a4c SIP/2.0
> Via: SIP/2.0/UDP 10.1.21.45;rport;branch=z9hG4bKDyS5SjU3vK33p
> Max-Forwards: 69
> From: "Steve" <sip:70904 at 10.1.21.45 <sip%3A70904 at 10.1.21.45>
> >;tag=gS62F28DB372F
> To: <sip:70904 at 10.1.56.106:44952;rinstance=481ff1bdc7ab2a4c>
> Call-ID: f4992499-931d-122c-34b1-003018ae1862
> CSeq: 112833059 INVITE
> Contact: <sip:mod_sofia at 10.1.21.45:5060>
> User-Agent: FreeSWITCH-mod_sofia/1.0.3-exported
> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
> NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
> Supported: 100rel, timer, precondition, path, replaces
> Allow-Events: talk, presence, dialog, call-info, sla,
> include-session-description, presence.winfo, message-summary, refer
> Content-Type: application/sdp
> Content-Disposition: session
> Content-Length: 328
> Remote-Party-ID: "Steve" <sip:70904 at 10.1.21.45 <sip%3A70904 at 10.1.21.45>
> >;screen=yes;privacy=off
> v=0
> o=FreeSWITCH 5141707032885022242 491120215176734726 IN IP4 10.1.21.45
> s=FreeSWITCH
> c=IN IP4 10.1.21.45
> t=0 0
> m=audio 22432 RTP/AVP 0 9 8 3 101 13
> a=rtpmap:0 PCMU/8000
> a=rtpmap:9 G722/8000
> a=rtpmap:8 PCMA/8000
> a=rtpmap:3 GSM/8000
> a=rtpmap:101 telephone-event/8000
> a=fmtp:101 0-16
> a=rtpmap:13 CN/8000
> a=ptime:20
> ------------------------------------------------------------------------
> recv 424 bytes from udp/[10.1.56.106]:44952 at 13:53:11.916589:
> ------------------------------------------------------------------------
> SIP/2.0 180 Ringing
> Via: SIP/2.0/UDP 10.1.21.45;rport=5060;branch=z9hG4bKDyS5SjU3vK33p
> Contact: <sip:70904 at 10.1.56.106:44952;rinstance=481ff1bdc7ab2a4c>
> To: <sip:70904 at 10.1.56.106:44952;rinstance=481ff1bdc7ab2a4c
> >;tag=fa138551
> From: "Steve"<sip:70904 at 10.1.21.45 <sip%3A70904 at 10.1.21.45>
> >;tag=gS62F28DB372F
> Call-ID: f4992499-931d-122c-34b1-003018ae1862
> CSeq: 112833059 INVITE
> User-Agent: X-Lite release 1011s stamp 41150
> Content-Length: 0
> ------------------------------------------------------------------------
> 2009-03-24 09:53:11 [NOTICE] sofia.c:2782 sofia_handle_sip_i_state()
> Ring-Ready sofia/internal/
> sip:70904 at 10.1.56.106:44952;rinstance=481ff1bdc7ab2a4c;fs_nat=yes!
> send 729 bytes to udp/[10.1.21.44]:5060 at 13:53:12.011060:
> ------------------------------------------------------------------------
> SIP/2.0 180 Ringing
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK7858c13c;rport=5060
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >;tag=FgDae7QaetHgm
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 103 INVITE
> Contact: <sip:mod_sofia at 10.1.21.45:5060;transport=udp>
> User-Agent: FreeSWITCH-mod_sofia/1.0.3-exported
> Accept: application/sdp
> Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, PRACK, MESSAGE, SUBSCRIBE,
> NOTIFY, REFER, UPDATE, REGISTER, INFO, PUBLISH
> Supported: 100rel, timer, precondition, path, replaces
> Allow-Events: talk, presence, dialog, call-info, sla,
> include-session-description, presence.winfo, message-summary, refer
> Content-Length: 0
> ------------------------------------------------------------------------
> 2009-03-24 09:53:12 [NOTICE] mod_sofia.c:1287 sofia_receive_message()
> Ring-Ready sofia/internal/70904 at 10.1.21.44!
> 2009-03-24 09:53:12 [NOTICE] switch_ivr_originate.c:1692
> switch_ivr_originate() Ring Ready sofia/internal/70904 at 10.1.21.44!
> recv 362 bytes from udp/[10.1.21.44]:5060 at 13:53:17.063013:
> ------------------------------------------------------------------------
> CANCEL sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>SIP/2.0
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK00d6d874;rport
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 103 CANCEL
> User-Agent: Asterisk PBX
> Max-Forwards: 70
> Content-Length: 0
> ------------------------------------------------------------------------
> send 327 bytes to udp/[10.1.21.44]:5060 at 13:53:17.063618:
> ------------------------------------------------------------------------
> SIP/2.0 481 Call/Transaction Does Not Exist
> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK00d6d874;rport=5060
> From: "Steve" <sip:70904 at 10.1.21.44 <sip%3A70904 at 10.1.21.44>
> >;tag=as4863e49a
> To: <sip:70904 at b-pbx-lab-1.mynet.net<sip%3A70904 at b-pbx-lab-1.mynet.net>
> >;tag=FgDae7QaetHgm
> Call-ID: 4db5b31f3f9d99c436804e4b54277b3e at 10.1.21.44
> CSeq: 103 CANCEL
> Content-Length: 0
> ------------------------------------------------------------------------
>
>
>
> 2009/3/24 Michael Jerris <mike at jerris.com>
>
>> This means we could not match the cancel to a current call dialog. I
>> would need to see the full sip trace of the call to know why, but typically
>> this is because of not matching call Id or to or from tags
>>
>> Mike
>>
>>
>> On Mar 24, 2009, at 9:43 AM, Steven Ward <steve.d.ward at gmail.com> wrote:
>>
>> A CANCEL request sent from my Asterisk UA (10.1.21.44) to FS (b-lab-1)
>> while the call is still ringing does not work.
>>
>> Why is this request resulting in a 481?
>>
>> I appreciate the help - I'm still just starting to learn SIP & FS. The
>> CANCEL request and 481 response appear as follows on my FS console:
>>
>>
>> recv 362 bytes from udp/[10.1.21.44]:5060 at 13:30:23.291616:
>>
>> ------------------------------------------------------------------------
>> CANCEL sip: <sip%3A70904 at b-pbx-lab-1.mynet.net>
>> 70904 at b-pbx-lab-1.mynet.net SIP/2.0
>> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK6f7f35ab;rport
>> From: "Steve" <sip: <sip%3A70904 at 10.1.21.44>70904 at 10.1.21.44
>> >;tag=as7f6965ea
>> To: <sip: <sip%3A70904 at b-lab-1.mynet.net>70904 at b-lab-1.mynet.net>
>> Call-ID: <237598fd102b739a03b4a4047bf69843 at 10.1.21.44>
>> 237598fd102b739a03b4a4047bf69843 at 10.1.21.44
>> CSeq: 103 CANCEL
>> User-Agent: Asterisk PBX
>> Max-Forwards: 70
>> Content-Length: 0
>>
>>
>> ------------------------------------------------------------------------
>> send 327 bytes to udp/[10.1.21.44]:5060 at 13:30:23.292235:
>>
>> ------------------------------------------------------------------------
>> SIP/2.0 481 Call/Transaction Does Not Exist
>> Via: SIP/2.0/UDP 10.1.21.44:5060;branch=z9hG4bK6f7f35ab;rport=5060
>> From: "Steve" <sip: <sip%3A70904 at 10.1.21.44>70904 at 10.1.21.44
>> >;tag=as7f6965ea
>> To: <sip: <sip%3A70904 at b-lab-1.mynet.net>70904 at b-lab-1.mynet.net
>> >;tag=71m745HKHKyjc
>> Call-ID: <237598fd102b739a03b4a4047bf69843 at 10.1.21.44>
>> 237598fd102b739a03b4a4047bf69843 at 10.1.21.44
>> CSeq: 103 CANCEL
>> Content-Length: 0
>> --------------------------------------
>>
>>
>>
>> Thanks. - SW
>>
>> _______________________________________________
>> Freeswitch-users mailing list
>> Freeswitch-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:<http://lists.freeswitch.org/mailman/options/freeswitch-users>
>> http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org
>>
>>
>> _______________________________________________
>> Freeswitch-users mailing list
>> Freeswitch-users at lists.freeswitch.org
>> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
>> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
>> http://www.freeswitch.org
>>
>>
> _______________________________________________
> Freeswitch-users mailing list
> Freeswitch-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
>
>
>
> _______________________________________________
> Freeswitch-users mailing list
> Freeswitch-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20090324/5ecb5fd8/attachment-0002.html
More information about the FreeSWITCH-users
mailing list