[Serusers] CANCEL and ACK in 0.8.12 problems (noise)
Jiri Kuthan
jiri at iptel.org
Sun Nov 23 20:48:15 CET 2003
that's not related to 8.12, that's related to your script
which drops ACK on the floor. If you introduced stateful
processing using t_relay for INVITE, ACK must be treated
the same way. If you drop the ACKs instead, transaction
processing will keep sending negative replies till it
gives up.
Changing the condition for INVITE to (method=="INVITE" ||
method=="ACK") should fix it. For negative replies,
request-uri must be same as for INVITEs and ACKs will follow
the same script processing path. Eventually, it will
hit t_relay, which will stop retransmitting 487.
BTW: BYE special-casing should normally not occur as all BYEs
should normaly be processed by loose_route.
-jiri
At 08:16 PM 11/22/2003, Greg Fausak wrote:
>I just loaded the 0.8.12 server on my lab linux 9.x box.
>Running postgres/2 current registrations, 123456 at named.com
>and 9723937976 at named.com. My configuration allows calls
>between these two no problem. I can hangup from either
>end with no problem. I am seeing a problem with a CANCEL
>message. If one end calls the other, and than CANCELs the
>communication before the other end ACKs, I get several messages
>CANCEL
>ACK
>CANCEL
>ACK
>...
>
>I read the serusers list and see that Maxim and Andrea reported
>the same problem. I don't see the problem in my production
>configuration on 0.8.11. What can I do to make the CANCEL work?
>
>Here is my configuration:
>UA1 XTEN XPRO
>UA2 Cisco 7960
>SER 0.8.12 configuration:
>-------------start---------------
>route{
>
> # initial sanity checks -- messages with
> # max_forwards==0, or excessively long requests
> if (!mf_process_maxfwd_header("10")) {
> sl_send_reply("483","Too Many Hops");
> break;
> };
> if (msg:len >= max_len ) {
> sl_send_reply("513", "Message too big");
> break;
> };
>
> # we record-route all messages -- to make sure that
> # subsequent messages will go through our proxy; that's
> # particularly good if upstream and downstream entities
> # use different transport protocol
> if (!method=="REGISTER") record_route();
>
> # subsequent messages withing a dialog should take the
> # path determined by record-routing
> if (loose_route()) {
> # mark routing logic in request
> append_hf("P-hint: rr-enforced\r\n");
> xlog("L_WARN", "LOOSE: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> setflag(1);
> setflag(2);
> route(1);
> break;
> };
>
> if (!uri==myself) {
> # mark routing logic in request
> append_hf("P-hint: outbound\r\n");
> route(1);
> break;
> };
>
> # if the request is for other domain use UsrLoc
> # (in case, it does not work, use the following command
> # with proper names and addresses in it)
> if (uri==myself) {
>
> if (method=="REGISTER") {
>
> if (!www_authorize("named.com", "subscriber")) {
> www_challenge("named.com", "0");
> break;
> };
>
> save("location");
> break;
> };
>
> lookup("aliases");
> if (!uri==myself) {
> append_hf("P-hint: outbound alias\r\n");
> route(1);
> break;
> };
>
> if (method=="INVITE") {
>
> if (!www_authorize("named.com", "subscriber")) {
> www_challenge("named.com", "0");
> break;
> };
> xlog("L_WARN", "INVITE: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> #
> if (lookup("location")) {
> route(1);
> break;
> };
>
> if(uri=~"sip:[0-9]{10}@.*")
> {
> xlog("L_WARN", "10DIGIT: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> route(2);
> break;
> }
> xlog("L_WARN", "UNKNOWN: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> sl_send_reply("580", "Sorry");
> break;
> };
>
> if (method=="CANCEL") {
>
> xlog("L_WARN", "CANCEL: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> route(2);
> break;
> };
>
> if (method=="BYE") {
>
> xlog("L_WARN", "BYE: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> route(2);
> break;
> };
>
> if (method=="ACK") {
>
> xlog("L_WARN", "ACK: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> break;
> };
>
> sl_send_reply("404", "Not Found");
> break;
> };
> xlog("L_WARN", "FAILATBOTTOM: %Ts call-id:%ci cseq:%ci contact:%ct from:%fu fromtag:%ft to:%tu totag:%tt method:%rm ruri:%ru messageid:%mi\n");
> break;
>}
>
>route[1]
>{
> # send it out now; use stateful forwarding as it works reliably
> # even for UDP2TCP
> if (!t_relay()) {
> sl_reply_error();
> };
>}
>
>route[2]
>{
> consume_credentials();
> rewritehostport("1.2.3.4:5060");
> if(!t_relay()) {
> sl_reply_error();
> break;
> };
>}
>
>--------------------
>here are the ngrep packets, from invite to duplicate CANCEL packets...
>#
>U 2003/11/22 13:10:32.356665 66.228.44.254:5060 -> 66.228.53.218:5060
>INVITE sip:9723937976 at 66.228.53.218:5060 SIP/2.0.
>Max-Forwards: 10.
>Record-Route: <sip:9723937976 at 66.228.44.254;ftag=320951244;lr>.
>Via: SIP/2.0/UDP 66.228.44.254;branch=z9hG4bKe198.142630c1.0.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>.
>Contact: <sip:123456 at 66.228.53.216:5060>.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 INVITE.
>Authorization: Digest username="123456",realm="named.com",nonce="3fbfb5d42576afa9e9384c4f0f16427e46909d1d",response="7bf9fe190978d98811d56ddb60dded2f",uri="sip:9723937976 at named.com".
>Content-Type: application/sdp.
>User-Agent: X-PRO build 1050.
>Content-Length: 322.
>.
>v=0.
>o=123456 485850365 485850365 IN IP4 66.228.53.216.
>s=X-PRO.
>c=IN IP4 66.228.53.216.
>t=0 0.
>m=audio 8000 RTP/AVP 0 8 3 4 98 97 101.
>a=rtpmap:0 pcmu/8000.
>a=rtpmap:8 pcma/8000.
>a=rtpmap:3 gsm/8000.
>a=rtpmap:4 G723/8000.
>a=rtpmap:98 iLBC/8000.
>a=rtpmap:97 speex/8000.
>a=rtpmap:101 telephone-event/8000.
>a=fmtp:101 0-15.
>
>#
>U 2003/11/22 13:10:32.619424 66.228.53.218:50560 -> 66.228.44.254:5060
>SIP/2.0 100 Trying.
>Via: SIP/2.0/UDP 66.228.44.254;branch=z9hG4bKe198.142630c1.0,SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 INVITE.
>Server: CSCO/5.
>Contact: <sip:9723937976 at 66.228.53.218:5060>.
>Record-Route: <sip:9723937976 at 66.228.44.254;ftag=320951244;lr>.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:32.728062 66.228.53.218:50561 -> 66.228.44.254:5060
>SIP/2.0 180 Ringing.
>Via: SIP/2.0/UDP 66.228.44.254;branch=z9hG4bKe198.142630c1.0,SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=000b5faab82400151dddd662-025452b6.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 INVITE.
>Server: CSCO/5.
>Contact: <sip:9723937976 at 66.228.53.218:5060>.
>Record-Route: <sip:9723937976 at 66.228.44.254;ftag=320951244;lr>.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:32.728480 66.228.44.254:5060 -> 66.228.53.216:5060
>SIP/2.0 180 Ringing.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=000b5faab82400151dddd662-025452b6.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 INVITE.
>Server: CSCO/5.
>Contact: <sip:9723937976 at 66.228.53.218:5060>.
>Record-Route: <sip:9723937976 at 66.228.44.254;ftag=320951244;lr>.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:34.846506 66.228.53.216:5060 -> 66.228.44.254:5060
>CANCEL sip:9723937976 at named.com SIP/2.0.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>.
>Contact: <sip:123456 at 66.228.53.216:5060>.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 CANCEL.
>User-Agent: X-PRO build 1050.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:34.847662 66.228.44.254:5060 -> 66.228.53.218:5060
>CANCEL sip:9723937976 at 66.228.53.218:5060 SIP/2.0.
>Max-Forwards: 10.
>Record-Route: <sip:9723937976 at 66.228.44.254;ftag=320951244;lr>.
>Via: SIP/2.0/UDP 66.228.44.254;branch=z9hG4bKe198.142630c1.0.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>.
>Contact: <sip:123456 at 66.228.53.216:5060>.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 CANCEL.
>User-Agent: X-PRO build 1050.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:34.847761 66.228.44.254:5060 -> 66.228.53.216:5060
>SIP/2.0 200 cancelling.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=a6a1c5f60faecf035a1ae5b6e96e979a-6763.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 CANCEL.
>Server: Sip EXpress router (0.8.12 (i386/linux)).
>Content-Length: 0.
>Warning: 392 66.228.44.254:5060 "Noisy feedback tells: pid=10695 req_src_ip=66.228.53.216 req_src_port=5060 in_uri=sip:9723937976 at named.com out_uri=sip:9723937976 at 65.77.154.243:5060 via_cnt==1".
>.
>
>
>#
>U 2003/11/22 13:10:34.847806 66.228.44.254:5060 -> 66.228.53.216:5060
>SIP/2.0 487 Request cancelled.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=a6a1c5f60faecf035a1ae5b6e96e979a-6763.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 INVITE.
>Server: Sip EXpress router (0.8.12 (i386/linux)).
>Content-Length: 0.
>Warning: 392 66.228.44.254:5060 "Noisy feedback tells: pid=10695 req_src_ip=66.228.53.216 req_src_port=5060 in_uri=sip:9723937976 at named.com out_uri=sip:9723937976 at 66.228.53.218:5060 via_cnt==1".
>.
>
>#
>U 2003/11/22 13:10:34.875833 66.228.53.216:5060 -> 66.228.44.254:5060
>ACK sip:9723937976 at named.com SIP/2.0.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=a6a1c5f60faecf035a1ae5b6e96e979a-6763.
>Contact: <sip:123456 at 66.228.53.216:5060>.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 ACK.
>Max-Forwards: 70.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:34.906960 66.228.53.218:50562 -> 66.228.44.254:5060
>SIP/2.0 200 OK.
>Via: SIP/2.0/UDP 66.228.44.254;branch=z9hG4bKe198.142630c1.0,SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=000b5faab82400151dddd662-025452b6.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 CANCEL.
>Server: CSCO/5.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:34.942865 66.228.53.218:50563 -> 66.228.44.254:5060
>SIP/2.0 487 Request Cancelled.
>Via: SIP/2.0/UDP 66.228.44.254;branch=z9hG4bKe198.142630c1.0,SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=000b5faab82400151dddd662-025452b6.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 INVITE.
>Server: CSCO/5.
>Contact: <sip:9723937976 at 66.228.53.218:5060>.
>Record-Route: <sip:9723937976 at 66.228.44.254;ftag=320951244;lr>.
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:34.943103 66.228.44.254:5060 -> 66.228.53.218:5060
>ACK sip:9723937976 at 66.228.53.218:5060 SIP/2.0.
>Via: SIP/2.0/UDP 66.228.44.254;branch=z9hG4bKe198.142630c1.0.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>To: <sip:9723937976 at named.com>;tag=000b5faab82400151dddd662-025452b6.
>CSeq: 19721 ACK.
>User-Agent: Sip EXpress router(0.8.12 (i386/linux)).
>Content-Length: 0.
>.
>
>#
>U 2003/11/22 13:10:35.649964 66.228.44.254:5060 -> 66.228.53.216:5060
>SIP/2.0 487 Request cancelled.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=a6a1c5f60faecf035a1ae5b6e96e979a-6763.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 INVITE.
>Server: Sip EXpress router (0.8.12 (i386/linux)).
>Content-Length: 0.
>Warning: 392 66.228.44.254:5060 "Noisy feedback tells: pid=10695 req_src_ip=66.228.53.216 req_src_port=5060 in_uri=sip:9723937976 at named.com out_uri=sip:9723937976 at 66.228.53.218:5060 via_cnt==1".
>.
>
>#
>U 2003/11/22 13:10:35.671936 66.228.53.216:5060 -> 66.228.44.254:5060
>ACK sip:9723937976 at named.com SIP/2.0.
>Via: SIP/2.0/UDP 66.228.53.216:5060.
>From: 123456 <sip:123456 at named.com>;tag=320951244.
>To: <sip:9723937976 at named.com>;tag=a6a1c5f60faecf035a1ae5b6e96e979a-6763.
>Contact: <sip:123456 at 66.228.53.216:5060>.
>Call-ID: A7A5E0C3-865F-41A1-9CAD-EE1B104D7244 at 66.228.53.216.
>CSeq: 19721 ACK.
>Max-Forwards: 70.
>Content-Length: 0.
>.
>
>
>The 487CANCEL/ACK/CANCEL/ACK/CANCEL/ACK goes on and on until
>something eventually times out. Anybody have any ideas? The CANCEL
>works, but the excess chatter isn't wanted.
>
>Thanks,
>---greg
>
>
>
>
>
>
>_______________________________________________
>Serusers mailing list
>serusers at lists.iptel.org
>http://lists.iptel.org/mailman/listinfo/serusers
--
Jiri Kuthan http://iptel.org/~jiri/
More information about the sr-users
mailing list