From misak@misak.dk Thu Oct 28 13:37:46 2010
From: Morten Isaksen <misak@misak.dk>
To: sr-users@lists.kamailio.org
Subject: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Thu, 28 Oct 2010 13:37:40 +0200
Message-ID: <AANLkTi=SMZWUXKtgf2z8Dh5p=5vr8PP89R-a2Ja5O_H=@mail.gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1351425843=="

--===============1351425843==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hi,

I have a strange problem with Kamailio 3.0.2. When one of our end
users makes a call Kamailio does not route the ACK (in response to the
200 OK). For all other end users it works fine.

For me it looks the the has_totag() checks for some reason fails and
then t_check_trans() thinks it is a ACK to a local transactions and
then terminates the script. Otherwise there should be more lines in
the log file.

The conf is pretty standard.

route{

        xlog("L_WARN", "New request - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu
IP=3D$si ID=3D$ci\n");
        xlog("L_WARN", "ua=3D$ua");
        if (!mf_process_maxfwd_header("10")) {
                sl_send_reply("483","Too Many Hops");
                exit;
        }

        if(!sanity_check("1511", "7"))
        {
                xlog("Malformed SIP message from $si:$sp\n");
                exit;
        }


        if (has_totag()) {
                xlog("L_WARN", "has_totag start - M=3D$rm RURI=3D$ru F=3D$fu
T=3D$tu IP=3D$si ID=3D$ci\n");
                # sequential request withing a dialog should
                # take the path determined by record-routing
                if (loose_route()) {
                        xlog("L_WARN", "loose_route - M=3D$rm RURI=3D$ru
F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
                        route(RELAY);
                } else {
                        if (is_method("SUBSCRIBE") && uri =3D=3D myself) {
                                # in-dialog subscribe requests
                                #route(PRESENCE);
                                exit;
                        }
                        if ( is_method("ACK") ) {
                                if ( t_check_trans() ) {
                                        xlog("L_WARN", "ACK
t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
                                        # non loose-route, but
stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
server
                                        t_relay();
                                        exit;
                                } else {
                                        xlog("Ignoring ACK - M=3D$rm
RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
                                        # ACK without matching
transaction ... ignore and discard.\n");
                                        exit;
                                }
                        }
                        sl_send_reply("404","Not here");
                }
                xlog("L_WARN", "has_totag end - M=3D$rm RURI=3D$ru F=3D$fu
T=3D$tu IP=3D$si ID=3D$ci\n");
                exit;
        }

        #initial requests

        # CANCEL processing
        if (is_method("CANCEL"))
        {
                if (t_check_trans())
                        t_relay();
                exit;
        }

        setflag(4);
        t_check_trans();

...

The log files show:

Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
<script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
87106(a)sip.uni-tel.dk IP=3D178.21.248.20 ID=3DAI231CA9BD0A4A1C53(a)10.0.0.150
Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
<script>: ua=3DAastra Intelligate




The trace

U 2010/10/28 10:51:02.616337 178.21.248.7:5060 -> 178.21.248.56:5060
INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
Record-Route: <sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>.
Record-Route: <sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
To: <sip:86987106(a)sip.uni-tel.dk>.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Max-Forwards: 68.
Contact: <sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7>.
Accept: application/sdp.
Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
P-Preferred-Identity: <sip:87776688(a)sip.uni-tel.dk>.
Privacy: none.
User-Agent: Aastra Intelligate.
Content-Type: application/sdp.
Content-Length: 280.
X-trunktype: IC.
.
v=3D0.
o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
s=3Dcall.
c=3DIN IP4 178.21.248.22.
t=3D0 0.
m=3Daudio 60984 RTP/AVP 8 0 18 101.
a=3Drtpmap:8 PCMA/8000.
a=3Drtpmap:0 PCMU/8000.
a=3Drtpmap:18 G729/8000.
a=3Drtpmap:101 telephone-event/8000.
a=3Dfmtp:101 0-15.
a=3Dsendrecv.
a=3Dptime:20.

#
U 2010/10/28 10:51:02.636854 178.21.248.56:5060 -> 178.21.248.7:5060
SIP/2.0 100 Trying.
Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Supported: em,timer,replaces,path,early-session,resource-priority.
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
Content-Length: 0.
.

#####
U 2010/10/28 10:51:04.134445 178.21.248.56:5060 -> 178.21.248.7:5060
SIP/2.0 183 Session Progress.
Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Contact: <sip:1105(a)178.21.248.56:5060>.
Record-Route: <sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Supported: em,timer,replaces,path,early-session,resource-priority.
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
Content-Type: application/sdp.
Content-Length: 259.
.
v=3D0.
o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
s=3DPhone-Call.
c=3DIN IP4 178.21.248.56.
t=3D0 0.
m=3Daudio 6050 RTP/AVP 8 101.
c=3DIN IP4 178.21.248.56.
a=3Drtpmap:8 PCMA/8000.
a=3Drtpmap:101 telephone-event/8000.
a=3Dfmtp:101 0-15.
a=3Dptime:20.
a=3Dsendrecv.

#
U 2010/10/28 10:51:04.134748 178.21.248.7:5060 -> 178.21.248.20:5060
SIP/2.0 183 Session Progress.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Contact: <sip:1105(a)178.21.248.56:5060>.
Record-Route: <sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Supported: em,timer,replaces,path,early-session,resource-priority.
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
Content-Type: application/sdp.
Content-Length: 259.
.
v=3D0.
o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
s=3DPhone-Call.
c=3DIN IP4 178.21.248.56.
t=3D0 0.
m=3Daudio 6050 RTP/AVP 8 101.
c=3DIN IP4 178.21.248.56.
a=3Drtpmap:8 PCMA/8000.
a=3Drtpmap:101 telephone-event/8000.
a=3Dfmtp:101 0-15.
a=3Dptime:20.
a=3Dsendrecv.

#
U 2010/10/28 10:51:04.136586 178.21.248.56:5060 -> 178.21.248.7:5060
SIP/2.0 180 Ringing.
Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Contact: <sip:1105(a)178.21.248.56:5060>.
Record-Route: <sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Supported: em,timer,replaces,path,early-session,resource-priority.
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
Content-Type: application/sdp.
Content-Length: 259.
.
v=3D0.
o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
s=3DPhone-Call.
c=3DIN IP4 178.21.248.56.
t=3D0 0.
m=3Daudio 6050 RTP/AVP 8 101.
c=3DIN IP4 178.21.248.56.
a=3Drtpmap:8 PCMA/8000.
a=3Drtpmap:101 telephone-event/8000.
a=3Dfmtp:101 0-15.
a=3Dptime:20.
a=3Dsendrecv.

#
U 2010/10/28 10:51:04.136837 178.21.248.7:5060 -> 178.21.248.20:5060
SIP/2.0 180 Ringing.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Contact: <sip:1105(a)178.21.248.56:5060>.
Record-Route: <sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Supported: em,timer,replaces,path,early-session,resource-priority.
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
Content-Type: application/sdp.
Content-Length: 259.
.
v=3D0.
o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
s=3DPhone-Call.
c=3DIN IP4 178.21.248.56.
t=3D0 0.
m=3Daudio 6050 RTP/AVP 8 101.
c=3DIN IP4 178.21.248.56.
a=3Drtpmap:8 PCMA/8000.
a=3Drtpmap:101 telephone-event/8000.
a=3Dfmtp:101 0-15.
a=3Dptime:20.
a=3Dsendrecv.

##############################
U 2010/10/28 10:51:12.881179 178.21.248.56:5060 -> 178.21.248.7:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Contact: <sip:1105(a)178.21.248.56:5060>.
Record-Route: <sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Supported: em,timer,replaces,path,early-session,resource-priority.
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
Content-Type: application/sdp.
Content-Length: 259.
.
v=3D0.
o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
s=3DPhone-Call.
c=3DIN IP4 178.21.248.56.
t=3D0 0.
m=3Daudio 6050 RTP/AVP 8 101.
c=3DIN IP4 178.21.248.56.
a=3Drtpmap:8 PCMA/8000.
a=3Drtpmap:101 telephone-event/8000.
a=3Dfmtp:101 0-15.
a=3Dptime:20.
a=3Dsendrecv.

#
U 2010/10/28 10:51:12.882388 178.21.248.7:5060 -> 178.21.248.20:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782cc2=
1592.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 INVITE.
Contact: <sip:1105(a)178.21.248.56:5060>.
Record-Route: <sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Supported: em,timer,replaces,path,early-session,resource-priority.
Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
Content-Type: application/sdp.
Content-Length: 259.
.
v=3D0.
o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
s=3DPhone-Call.
c=3DIN IP4 178.21.248.56.
t=3D0 0.
m=3Daudio 6050 RTP/AVP 8 101.
c=3DIN IP4 178.21.248.56.
a=3Drtpmap:8 PCMA/8000.
a=3Drtpmap:101 telephone-event/8000.
a=3Dfmtp:101 0-15.
a=3Dptime:20.
a=3Dsendrecv.

##### <<<<<<<<<<<<<<<<<<<<<<  This is the problem packet >>>>>>>>>>>>>>>>>>>>>
U 2010/10/28 10:51:13.267863 178.21.248.20:5060 -> 178.21.248.7:5060
ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
Record-Route: <sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216eb2f7=
233f.
To: <sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
From: <sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 ACK.
Max-Forwards: 69.
Route: <sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db02=
>.
User-Agent: Aastra Intelligate.
Content-Length: 0.








--=20
Morten Isaksen


--===============1351425843==--


From miconda@gmail.com Fri Oct 29 10:59:38 2010
From: Daniel-Constantin Mierla <miconda@gmail.com>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Fri, 29 Oct 2010 10:59:34 +0200
Message-ID: <4CCA8CF6.3030906@gmail.com>
In-Reply-To: <AANLkTi=SMZWUXKtgf2z8Dh5p=5vr8PP89R-a2Ja5O_H=@mail.gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1847110221=="

--===============1847110221==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hello,

On 10/28/10 1:37 PM, Morten Isaksen wrote:
> Hi,
>
> I have a strange problem with Kamailio 3.0.2. When one of our end
> users makes a call Kamailio does not route the ACK (in response to the
> 200 OK). For all other end users it works fine.
>
> For me it looks the the has_totag() checks for some reason fails and
> then t_check_trans() thinks it is a ACK to a local transactions and
> then terminates the script. Otherwise there should be more lines in
> the log file.

if you add an xlog() after the if with has_totag(), do you get the=20
message in the logs?

Cheers,
Daniel

> The conf is pretty standard.
>
> route{
>
>          xlog("L_WARN", "New request - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu
> IP=3D$si ID=3D$ci\n");
>          xlog("L_WARN", "ua=3D$ua");
>          if (!mf_process_maxfwd_header("10")) {
>                  sl_send_reply("483","Too Many Hops");
>                  exit;
>          }
>
>          if(!sanity_check("1511", "7"))
>          {
>                  xlog("Malformed SIP message from $si:$sp\n");
>                  exit;
>          }
>
>
>          if (has_totag()) {
>                  xlog("L_WARN", "has_totag start - M=3D$rm RURI=3D$ru F=3D$=
fu
> T=3D$tu IP=3D$si ID=3D$ci\n");
>                  # sequential request withing a dialog should
>                  # take the path determined by record-routing
>                  if (loose_route()) {
>                          xlog("L_WARN", "loose_route - M=3D$rm RURI=3D$ru
> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>                          route(RELAY);
>                  } else {
>                          if (is_method("SUBSCRIBE")&&  uri =3D=3D myself) {
>                                  # in-dialog subscribe requests
>                                  #route(PRESENCE);
>                                  exit;
>                          }
>                          if ( is_method("ACK") ) {
>                                  if ( t_check_trans() ) {
>                                          xlog("L_WARN", "ACK
> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>                                          # non loose-route, but
> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
> server
>                                          t_relay();
>                                          exit;
>                                  } else {
>                                          xlog("Ignoring ACK - M=3D$rm
> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>                                          # ACK without matching
> transaction ... ignore and discard.\n");
>                                          exit;
>                                  }
>                          }
>                          sl_send_reply("404","Not here");
>                  }
>                  xlog("L_WARN", "has_totag end - M=3D$rm RURI=3D$ru F=3D$fu
> T=3D$tu IP=3D$si ID=3D$ci\n");
>                  exit;
>          }
>
>          #initial requests
>
>          # CANCEL processing
>          if (is_method("CANCEL"))
>          {
>                  if (t_check_trans())
>                          t_relay();
>                  exit;
>          }
>
>          setflag(4);
>          t_check_trans();
>
> ...
>
> The log files show:
>
> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20 ID=3DAI231CA9BD0A4A1C53(a)10.0.0.=
150
> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
> <script>: ua=3DAastra Intelligate
>
>
>
>
> The trace
>
> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 ->  178.21.248.56:5060
> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>.
> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> To:<sip:86987106(a)sip.uni-tel.dk>.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Max-Forwards: 68.
> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7>.
> Accept: application/sdp.
> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
> Privacy: none.
> User-Agent: Aastra Intelligate.
> Content-Type: application/sdp.
> Content-Length: 280.
> X-trunktype: IC.
> .
> v=3D0.
> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
> s=3Dcall.
> c=3DIN IP4 178.21.248.22.
> t=3D0 0.
> m=3Daudio 60984 RTP/AVP 8 0 18 101.
> a=3Drtpmap:8 PCMA/8000.
> a=3Drtpmap:0 PCMU/8000.
> a=3Drtpmap:18 G729/8000.
> a=3Drtpmap:101 telephone-event/8000.
> a=3Dfmtp:101 0-15.
> a=3Dsendrecv.
> a=3Dptime:20.
>
> #
> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 ->  178.21.248.7:5060
> SIP/2.0 100 Trying.
> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Supported: em,timer,replaces,path,early-session,resource-priority.
> Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
> Content-Length: 0.
> .
>
> #####
> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 ->  178.21.248.7:5060
> SIP/2.0 183 Session Progress.
> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Contact:<sip:1105(a)178.21.248.56:5060>.
> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Supported: em,timer,replaces,path,early-session,resource-priority.
> Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
> Content-Type: application/sdp.
> Content-Length: 259.
> .
> v=3D0.
> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
> s=3DPhone-Call.
> c=3DIN IP4 178.21.248.56.
> t=3D0 0.
> m=3Daudio 6050 RTP/AVP 8 101.
> c=3DIN IP4 178.21.248.56.
> a=3Drtpmap:8 PCMA/8000.
> a=3Drtpmap:101 telephone-event/8000.
> a=3Dfmtp:101 0-15.
> a=3Dptime:20.
> a=3Dsendrecv.
>
> #
> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 ->  178.21.248.20:5060
> SIP/2.0 183 Session Progress.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Contact:<sip:1105(a)178.21.248.56:5060>.
> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Supported: em,timer,replaces,path,early-session,resource-priority.
> Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
> Content-Type: application/sdp.
> Content-Length: 259.
> .
> v=3D0.
> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
> s=3DPhone-Call.
> c=3DIN IP4 178.21.248.56.
> t=3D0 0.
> m=3Daudio 6050 RTP/AVP 8 101.
> c=3DIN IP4 178.21.248.56.
> a=3Drtpmap:8 PCMA/8000.
> a=3Drtpmap:101 telephone-event/8000.
> a=3Dfmtp:101 0-15.
> a=3Dptime:20.
> a=3Dsendrecv.
>
> #
> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 ->  178.21.248.7:5060
> SIP/2.0 180 Ringing.
> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Contact:<sip:1105(a)178.21.248.56:5060>.
> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Supported: em,timer,replaces,path,early-session,resource-priority.
> Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
> Content-Type: application/sdp.
> Content-Length: 259.
> .
> v=3D0.
> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
> s=3DPhone-Call.
> c=3DIN IP4 178.21.248.56.
> t=3D0 0.
> m=3Daudio 6050 RTP/AVP 8 101.
> c=3DIN IP4 178.21.248.56.
> a=3Drtpmap:8 PCMA/8000.
> a=3Drtpmap:101 telephone-event/8000.
> a=3Dfmtp:101 0-15.
> a=3Dptime:20.
> a=3Dsendrecv.
>
> #
> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 ->  178.21.248.20:5060
> SIP/2.0 180 Ringing.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Contact:<sip:1105(a)178.21.248.56:5060>.
> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Supported: em,timer,replaces,path,early-session,resource-priority.
> Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
> Content-Type: application/sdp.
> Content-Length: 259.
> .
> v=3D0.
> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
> s=3DPhone-Call.
> c=3DIN IP4 178.21.248.56.
> t=3D0 0.
> m=3Daudio 6050 RTP/AVP 8 101.
> c=3DIN IP4 178.21.248.56.
> a=3Drtpmap:8 PCMA/8000.
> a=3Drtpmap:101 telephone-event/8000.
> a=3Dfmtp:101 0-15.
> a=3Dptime:20.
> a=3Dsendrecv.
>
> ##############################
> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 ->  178.21.248.7:5060
> SIP/2.0 200 OK.
> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Contact:<sip:1105(a)178.21.248.56:5060>.
> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Supported: em,timer,replaces,path,early-session,resource-priority.
> Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
> Content-Type: application/sdp.
> Content-Length: 259.
> .
> v=3D0.
> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
> s=3DPhone-Call.
> c=3DIN IP4 178.21.248.56.
> t=3D0 0.
> m=3Daudio 6050 RTP/AVP 8 101.
> c=3DIN IP4 178.21.248.56.
> a=3Drtpmap:8 PCMA/8000.
> a=3Drtpmap:101 telephone-event/8000.
> a=3Dfmtp:101 0-15.
> a=3Dptime:20.
> a=3Dsendrecv.
>
> #
> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 ->  178.21.248.20:5060
> SIP/2.0 200 OK.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782c=
c21592.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 INVITE.
> Contact:<sip:1105(a)178.21.248.56:5060>.
> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Supported: em,timer,replaces,path,early-session,resource-priority.
> Allow: REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
> Content-Type: application/sdp.
> Content-Length: 259.
> .
> v=3D0.
> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
> s=3DPhone-Call.
> c=3DIN IP4 178.21.248.56.
> t=3D0 0.
> m=3Daudio 6050 RTP/AVP 8 101.
> c=3DIN IP4 178.21.248.56.
> a=3Drtpmap:8 PCMA/8000.
> a=3Drtpmap:101 telephone-event/8000.
> a=3Dfmtp:101 0-15.
> a=3Dptime:20.
> a=3Dsendrecv.
>
> #####<<<<<<<<<<<<<<<<<<<<<<   This is the problem packet>>>>>>>>>>>>>>>>>>>=
>>
> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->  178.21.248.7:5060
> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216eb2=
f7233f.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 ACK.
> Max-Forwards: 69.
> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db0=
2>.
> User-Agent: Aastra Intelligate.
> Content-Length: 0.
>
>
>
>
>
>
>
>

--=20
Daniel-Constantin Mierla
http://www.asipto.com



--===============1847110221==--


From misak@misak.dk Mon Nov  8 15:00:24 2010
From: Morten Isaksen <misak@misak.dk>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Mon, 08 Nov 2010 15:00:17 +0100
Message-ID: <AANLkTinYimHwzBxtvpYwH2ZMUSLkqN1HRORw8gHW915Z@mail.gmail.com>
In-Reply-To: <4CCA8CF6.3030906@gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1337521809=="

--===============1337521809==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hi,

On Fri, Oct 29, 2010 at 10:59 AM, Daniel-Constantin Mierla
<miconda(a)gmail.com> wrote:
> Hello,
>
> On 10/28/10 1:37 PM, Morten Isaksen wrote:
>>
>> Hi,
>>
>> I have a strange problem with Kamailio 3.0.2. When one of our end
>> users makes a call Kamailio does not route the ACK (in response to the
>> 200 OK). For all other end users it works fine.
>>
>> For me it looks the the has_totag() checks for some reason fails and
>> then t_check_trans() thinks it is a ACK to a local transactions and
>> then terminates the script. Otherwise there should be more lines in
>> the log file.
>
> if you add an xlog() after the if with has_totag(), do you get the message
> in the logs?


Sorry for the delay, but a had to wait for the customer to make a test call.

I placed a xlog("L_WARN", "has_totag after - M=3D$rm RURI=3D$ru F=3D$fu
T=3D$tu IP=3D$si ID=3D$ci\n"); just after the if (has_totag()) { .. } and it
does not show in the log.

It looks very strange to me. Do you have any ideas what is wrong.

/Morten

> Cheers,
> Daniel
>
>> The conf is pretty standard.
>>
>> route{
>>
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "New request - M=3D$rm RURI=3D$=
ru F=3D$fu T=3D$tu
>> IP=3D$si ID=3D$ci\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "ua=3D$ua");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (!mf_process_maxfwd_header("10")) {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 sl_send_reply("483=
","Too Many Hops");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if(!sanity_check("1511", "7"))
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("Malformed SI=
P message from $si:$sp\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>
>>
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (has_totag()) {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "ha=
s_totag start - M=3D$rm RURI=3D$ru F=3D$fu
>> T=3D$tu IP=3D$si ID=3D$ci\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # sequential reque=
st withing a dialog should
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # take the path de=
termined by record-routing
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (loose_route())=
 {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 xlog("L_WARN", "loose_route - M=3D$rm RURI=3D$ru
>> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 route(RELAY);
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 if (is_method("SUBSCRIBE")&& =C2=A0uri =3D=3D myself) {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # in-dialog subscribe requests
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 #route(PRESENCE);
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 }
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 if ( is_method("ACK") ) {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if ( t_check_trans() ) {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WA=
RN", "ACK
>> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # non loos=
e-route, but
>> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
>> server
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_relay();
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("Igno=
ring ACK - M=3D$rm
>> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # ACK with=
out matching
>> transaction ... ignore and discard.\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 }
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 sl_send_reply("404","Not here");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "ha=
s_totag end - M=3D$rm RURI=3D$ru F=3D$fu
>> T=3D$tu IP=3D$si ID=3D$ci\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 #initial requests
>>
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 # CANCEL processing
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (is_method("CANCEL"))
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (t_check_trans(=
))
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 t_relay();
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 setflag(4);
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_check_trans();
>>
>> ...
>>
>> The log files show:
>>
>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
>> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
>> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20 ID=3DAI231CA9BD0A4A1C53(a)10.0.0=
.150
>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>> <script>: ua=3DAastra Intelligate
>>
>>
>>
>>
>> The trace
>>
>> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 -> =C2=A0178.21.248.56:5060
>> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
>>
>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>.
>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> To:<sip:86987106(a)sip.uni-tel.dk>.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Max-Forwards: 68.
>> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7>.
>> Accept: application/sdp.
>> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
>> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
>> Privacy: none.
>> User-Agent: Aastra Intelligate.
>> Content-Type: application/sdp.
>> Content-Length: 280.
>> X-trunktype: IC.
>> .
>> v=3D0.
>> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
>> s=3Dcall.
>> c=3DIN IP4 178.21.248.22.
>> t=3D0 0.
>> m=3Daudio 60984 RTP/AVP 8 0 18 101.
>> a=3Drtpmap:8 PCMA/8000.
>> a=3Drtpmap:0 PCMU/8000.
>> a=3Drtpmap:18 G729/8000.
>> a=3Drtpmap:101 telephone-event/8000.
>> a=3Dfmtp:101 0-15.
>> a=3Dsendrecv.
>> a=3Dptime:20.
>>
>> #
>> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>> SIP/2.0 100 Trying.
>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Supported: em,timer,replaces,path,early-session,resource-priority.
>> Allow:
>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,U=
PDATE.
>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>> Content-Length: 0.
>> .
>>
>> #####
>> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>> SIP/2.0 183 Session Progress.
>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>
>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Supported: em,timer,replaces,path,early-session,resource-priority.
>> Allow:
>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,U=
PDATE.
>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>> Content-Type: application/sdp.
>> Content-Length: 259.
>> .
>> v=3D0.
>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>> s=3DPhone-Call.
>> c=3DIN IP4 178.21.248.56.
>> t=3D0 0.
>> m=3Daudio 6050 RTP/AVP 8 101.
>> c=3DIN IP4 178.21.248.56.
>> a=3Drtpmap:8 PCMA/8000.
>> a=3Drtpmap:101 telephone-event/8000.
>> a=3Dfmtp:101 0-15.
>> a=3Dptime:20.
>> a=3Dsendrecv.
>>
>> #
>> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 -> =C2=A0178.21.248.20:5060
>> SIP/2.0 183 Session Progress.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>
>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Supported: em,timer,replaces,path,early-session,resource-priority.
>> Allow:
>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,U=
PDATE.
>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>> Content-Type: application/sdp.
>> Content-Length: 259.
>> .
>> v=3D0.
>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>> s=3DPhone-Call.
>> c=3DIN IP4 178.21.248.56.
>> t=3D0 0.
>> m=3Daudio 6050 RTP/AVP 8 101.
>> c=3DIN IP4 178.21.248.56.
>> a=3Drtpmap:8 PCMA/8000.
>> a=3Drtpmap:101 telephone-event/8000.
>> a=3Dfmtp:101 0-15.
>> a=3Dptime:20.
>> a=3Dsendrecv.
>>
>> #
>> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>> SIP/2.0 180 Ringing.
>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>
>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Supported: em,timer,replaces,path,early-session,resource-priority.
>> Allow:
>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,U=
PDATE.
>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>> Content-Type: application/sdp.
>> Content-Length: 259.
>> .
>> v=3D0.
>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>> s=3DPhone-Call.
>> c=3DIN IP4 178.21.248.56.
>> t=3D0 0.
>> m=3Daudio 6050 RTP/AVP 8 101.
>> c=3DIN IP4 178.21.248.56.
>> a=3Drtpmap:8 PCMA/8000.
>> a=3Drtpmap:101 telephone-event/8000.
>> a=3Dfmtp:101 0-15.
>> a=3Dptime:20.
>> a=3Dsendrecv.
>>
>> #
>> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 -> =C2=A0178.21.248.20:5060
>> SIP/2.0 180 Ringing.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>
>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Supported: em,timer,replaces,path,early-session,resource-priority.
>> Allow:
>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,U=
PDATE.
>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>> Content-Type: application/sdp.
>> Content-Length: 259.
>> .
>> v=3D0.
>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>> s=3DPhone-Call.
>> c=3DIN IP4 178.21.248.56.
>> t=3D0 0.
>> m=3Daudio 6050 RTP/AVP 8 101.
>> c=3DIN IP4 178.21.248.56.
>> a=3Drtpmap:8 PCMA/8000.
>> a=3Drtpmap:101 telephone-event/8000.
>> a=3Dfmtp:101 0-15.
>> a=3Dptime:20.
>> a=3Dsendrecv.
>>
>> ##############################
>> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>> SIP/2.0 200 OK.
>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>
>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Supported: em,timer,replaces,path,early-session,resource-priority.
>> Allow:
>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,U=
PDATE.
>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>> Content-Type: application/sdp.
>> Content-Length: 259.
>> .
>> v=3D0.
>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>> s=3DPhone-Call.
>> c=3DIN IP4 178.21.248.56.
>> t=3D0 0.
>> m=3Daudio 6050 RTP/AVP 8 101.
>> c=3DIN IP4 178.21.248.56.
>> a=3Drtpmap:8 PCMA/8000.
>> a=3Drtpmap:101 telephone-event/8000.
>> a=3Dfmtp:101 0-15.
>> a=3Dptime:20.
>> a=3Dsendrecv.
>>
>> #
>> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 -> =C2=A0178.21.248.20:5060
>> SIP/2.0 200 OK.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c782=
cc21592.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 INVITE.
>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>
>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Supported: em,timer,replaces,path,early-session,resource-priority.
>> Allow:
>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,U=
PDATE.
>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>> Content-Type: application/sdp.
>> Content-Length: 259.
>> .
>> v=3D0.
>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>> s=3DPhone-Call.
>> c=3DIN IP4 178.21.248.56.
>> t=3D0 0.
>> m=3Daudio 6050 RTP/AVP 8 101.
>> c=3DIN IP4 178.21.248.56.
>> a=3Drtpmap:8 PCMA/8000.
>> a=3Drtpmap:101 telephone-event/8000.
>> a=3Dfmtp:101 0-15.
>> a=3Dptime:20.
>> a=3Dsendrecv.
>>
>> #####<<<<<<<<<<<<<<<<<<<<<< =C2=A0 This is the problem
>> packet>>>>>>>>>>>>>>>>>>>>>
>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 -> =C2=A0178.21.248.7:5060
>> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>> Via: SIP/2.0/UDP
>>
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216eb=
2f7233f.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 ACK.
>> Max-Forwards: 69.
>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>.
>> User-Agent: Aastra Intelligate.
>> Content-Length: 0.
>>
>>
>>
>>
>>
>>
>>
>>
>
> --
> Daniel-Constantin Mierla
> http://www.asipto.com
>
>
> _______________________________________________
> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
> sr-users(a)lists.sip-router.org
> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>



--=20
Morten Isaksen


--===============1337521809==--


From misak@misak.dk Thu Nov 11 13:50:46 2010
From: Morten Isaksen <misak@misak.dk>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Thu, 11 Nov 2010 13:50:37 +0100
Message-ID: <AANLkTikiFgfk+AXsfhdaenoz3-cRM4dZuLp4w0d_T4Mt@mail.gmail.com>
In-Reply-To: <AANLkTinYimHwzBxtvpYwH2ZMUSLkqN1HRORw8gHW915Z@mail.gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============0589658533=="

--===============0589658533==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hi,

I narrowed it down to the sanity_check.

       if(!sanity_check("1511", "7"))
       {
               xlog("L_WARN", "sanity check - M=3D$rm RURI=3D$ru F=3D$fu
T=3D$tu IP=3D$si ID=3D$ci\n");
               exit;
       }

The sanity_check fails but does not send a reply back or log the above
line. I have commented it out and now the ACK is forwarded.

/Morten

On Mon, Nov 8, 2010 at 3:00 PM, Morten Isaksen <misak(a)misak.dk> wrote:
> Hi,
>
> On Fri, Oct 29, 2010 at 10:59 AM, Daniel-Constantin Mierla
> <miconda(a)gmail.com> wrote:
>> Hello,
>>
>> On 10/28/10 1:37 PM, Morten Isaksen wrote:
>>>
>>> Hi,
>>>
>>> I have a strange problem with Kamailio 3.0.2. When one of our end
>>> users makes a call Kamailio does not route the ACK (in response to the
>>> 200 OK). For all other end users it works fine.
>>>
>>> For me it looks the the has_totag() checks for some reason fails and
>>> then t_check_trans() thinks it is a ACK to a local transactions and
>>> then terminates the script. Otherwise there should be more lines in
>>> the log file.
>>
>> if you add an xlog() after the if with has_totag(), do you get the message
>> in the logs?
>
>
> Sorry for the delay, but a had to wait for the customer to make a test call.
>
> I placed a xlog("L_WARN", "has_totag after - M=3D$rm RURI=3D$ru F=3D$fu
> T=3D$tu IP=3D$si ID=3D$ci\n"); just after the if (has_totag()) { .. } and it
> does not show in the log.
>
> It looks very strange to me. Do you have any ideas what is wrong.
>
> /Morten
>
>> Cheers,
>> Daniel
>>
>>> The conf is pretty standard.
>>>
>>> route{
>>>
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "New request - M=3D$rm RURI=3D=
$ru F=3D$fu T=3D$tu
>>> IP=3D$si ID=3D$ci\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "ua=3D$ua");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (!mf_process_maxfwd_header("10")) {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 sl_send_reply("48=
3","Too Many Hops");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if(!sanity_check("1511", "7"))
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("Malformed S=
IP message from $si:$sp\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>
>>>
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (has_totag()) {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "h=
as_totag start - M=3D$rm RURI=3D$ru F=3D$fu
>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # sequential requ=
est withing a dialog should
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # take the path d=
etermined by record-routing
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (loose_route()=
) {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 xlog("L_WARN", "loose_route - M=3D$rm RURI=3D$ru
>>> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 route(RELAY);
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 if (is_method("SUBSCRIBE")&& =C2=A0uri =3D=3D myself) {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # in-dialog subscribe requests
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 #route(PRESENCE);
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 }
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 if ( is_method("ACK") ) {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if ( t_check_trans() ) {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WA=
RN", "ACK
>>> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # non loos=
e-route, but
>>> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
>>> server
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_relay();
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("Igno=
ring ACK - M=3D$rm
>>> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # ACK with=
out matching
>>> transaction ... ignore and discard.\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 }
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 sl_send_reply("404","Not here");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "h=
as_totag end - M=3D$rm RURI=3D$ru F=3D$fu
>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 #initial requests
>>>
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 # CANCEL processing
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (is_method("CANCEL"))
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (t_check_trans=
())
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 t_relay();
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 setflag(4);
>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_check_trans();
>>>
>>> ...
>>>
>>> The log files show:
>>>
>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
>>> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
>>> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20 ID=3DAI231CA9BD0A4A1C53(a)10.0.=
0.150
>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>> <script>: ua=3DAastra Intelligate
>>>
>>>
>>>
>>>
>>> The trace
>>>
>>> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 -> =C2=A0178.21.248.56:5060
>>> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
>>>
>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>.
>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> To:<sip:86987106(a)sip.uni-tel.dk>.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Max-Forwards: 68.
>>> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7>.
>>> Accept: application/sdp.
>>> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
>>> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
>>> Privacy: none.
>>> User-Agent: Aastra Intelligate.
>>> Content-Type: application/sdp.
>>> Content-Length: 280.
>>> X-trunktype: IC.
>>> .
>>> v=3D0.
>>> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
>>> s=3Dcall.
>>> c=3DIN IP4 178.21.248.22.
>>> t=3D0 0.
>>> m=3Daudio 60984 RTP/AVP 8 0 18 101.
>>> a=3Drtpmap:8 PCMA/8000.
>>> a=3Drtpmap:0 PCMU/8000.
>>> a=3Drtpmap:18 G729/8000.
>>> a=3Drtpmap:101 telephone-event/8000.
>>> a=3Dfmtp:101 0-15.
>>> a=3Dsendrecv.
>>> a=3Dptime:20.
>>>
>>> #
>>> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>>> SIP/2.0 100 Trying.
>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>> Allow:
>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,=
UPDATE.
>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>> Content-Length: 0.
>>> .
>>>
>>> #####
>>> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>>> SIP/2.0 183 Session Progress.
>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>
>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>> Allow:
>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,=
UPDATE.
>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>> Content-Type: application/sdp.
>>> Content-Length: 259.
>>> .
>>> v=3D0.
>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>> s=3DPhone-Call.
>>> c=3DIN IP4 178.21.248.56.
>>> t=3D0 0.
>>> m=3Daudio 6050 RTP/AVP 8 101.
>>> c=3DIN IP4 178.21.248.56.
>>> a=3Drtpmap:8 PCMA/8000.
>>> a=3Drtpmap:101 telephone-event/8000.
>>> a=3Dfmtp:101 0-15.
>>> a=3Dptime:20.
>>> a=3Dsendrecv.
>>>
>>> #
>>> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 -> =C2=A0178.21.248.20:5060
>>> SIP/2.0 183 Session Progress.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>
>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>> Allow:
>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,=
UPDATE.
>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>> Content-Type: application/sdp.
>>> Content-Length: 259.
>>> .
>>> v=3D0.
>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>> s=3DPhone-Call.
>>> c=3DIN IP4 178.21.248.56.
>>> t=3D0 0.
>>> m=3Daudio 6050 RTP/AVP 8 101.
>>> c=3DIN IP4 178.21.248.56.
>>> a=3Drtpmap:8 PCMA/8000.
>>> a=3Drtpmap:101 telephone-event/8000.
>>> a=3Dfmtp:101 0-15.
>>> a=3Dptime:20.
>>> a=3Dsendrecv.
>>>
>>> #
>>> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>>> SIP/2.0 180 Ringing.
>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>
>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>> Allow:
>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,=
UPDATE.
>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>> Content-Type: application/sdp.
>>> Content-Length: 259.
>>> .
>>> v=3D0.
>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>> s=3DPhone-Call.
>>> c=3DIN IP4 178.21.248.56.
>>> t=3D0 0.
>>> m=3Daudio 6050 RTP/AVP 8 101.
>>> c=3DIN IP4 178.21.248.56.
>>> a=3Drtpmap:8 PCMA/8000.
>>> a=3Drtpmap:101 telephone-event/8000.
>>> a=3Dfmtp:101 0-15.
>>> a=3Dptime:20.
>>> a=3Dsendrecv.
>>>
>>> #
>>> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 -> =C2=A0178.21.248.20:5060
>>> SIP/2.0 180 Ringing.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>
>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>> Allow:
>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,=
UPDATE.
>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>> Content-Type: application/sdp.
>>> Content-Length: 259.
>>> .
>>> v=3D0.
>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>> s=3DPhone-Call.
>>> c=3DIN IP4 178.21.248.56.
>>> t=3D0 0.
>>> m=3Daudio 6050 RTP/AVP 8 101.
>>> c=3DIN IP4 178.21.248.56.
>>> a=3Drtpmap:8 PCMA/8000.
>>> a=3Drtpmap:101 telephone-event/8000.
>>> a=3Dfmtp:101 0-15.
>>> a=3Dptime:20.
>>> a=3Dsendrecv.
>>>
>>> ##############################
>>> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 -> =C2=A0178.21.248.7:5060
>>> SIP/2.0 200 OK.
>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>
>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>> Allow:
>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,=
UPDATE.
>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>> Content-Type: application/sdp.
>>> Content-Length: 259.
>>> .
>>> v=3D0.
>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>> s=3DPhone-Call.
>>> c=3DIN IP4 178.21.248.56.
>>> t=3D0 0.
>>> m=3Daudio 6050 RTP/AVP 8 101.
>>> c=3DIN IP4 178.21.248.56.
>>> a=3Drtpmap:8 PCMA/8000.
>>> a=3Drtpmap:101 telephone-event/8000.
>>> a=3Dfmtp:101 0-15.
>>> a=3Dptime:20.
>>> a=3Dsendrecv.
>>>
>>> #
>>> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 -> =C2=A0178.21.248.20:5060
>>> SIP/2.0 200 OK.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c78=
2cc21592.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 INVITE.
>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>
>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>> Allow:
>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE,=
UPDATE.
>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>> Content-Type: application/sdp.
>>> Content-Length: 259.
>>> .
>>> v=3D0.
>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>> s=3DPhone-Call.
>>> c=3DIN IP4 178.21.248.56.
>>> t=3D0 0.
>>> m=3Daudio 6050 RTP/AVP 8 101.
>>> c=3DIN IP4 178.21.248.56.
>>> a=3Drtpmap:8 PCMA/8000.
>>> a=3Drtpmap:101 telephone-event/8000.
>>> a=3Dfmtp:101 0-15.
>>> a=3Dptime:20.
>>> a=3Dsendrecv.
>>>
>>> #####<<<<<<<<<<<<<<<<<<<<<< =C2=A0 This is the problem
>>> packet>>>>>>>>>>>>>>>>>>>>>
>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 -> =C2=A0178.21.248.7:5060
>>> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>> Via: SIP/2.0/UDP
>>>
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216e=
b2f7233f.
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 ACK.
>>> Max-Forwards: 69.
>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>.
>>> User-Agent: Aastra Intelligate.
>>> Content-Length: 0.
>>>
>>>
>>>
>>>
>>>
>>>
>>>
>>>
>>
>> --
>> Daniel-Constantin Mierla
>> http://www.asipto.com
>>
>>
>> _______________________________________________
>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>> sr-users(a)lists.sip-router.org
>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>
>
>
>
> --
> Morten Isaksen
>



--=20
Morten Isaksen


--===============0589658533==--


From miconda@gmail.com Thu Nov 11 20:20:15 2010
From: Daniel-Constantin Mierla <miconda@gmail.com>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Thu, 11 Nov 2010 20:20:10 +0100
Message-ID: <4CDC41EA.5040001@gmail.com>
In-Reply-To: <AANLkTikiFgfk+AXsfhdaenoz3-cRM4dZuLp4w0d_T4Mt@mail.gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1669116528=="

--===============1669116528==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hello,

looking now again at the trace you sent first time, the ACK is:

U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->  178.21.248.7:5060
ACKsip:1105(a)178.21.248.56:5060  SIP/2.0.
Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
Via: SIP/2.0/UDP
87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216eb2f7=
233f.
To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
Call-ID:AI231CA9BD0A4A1C53(a)10.0.0.150.
CSeq: 2 ACK.
Max-Forwards: 69.
Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db02>.
User-Agent: Aastra Intelligate.
Content-Length: 0.

I thought that it may be the email body formatting so that the second=20
Via header body gets on next line after SIP/2.0/UDP. Can you check your=20
trace, is it on next line (i.e., there is a new line)? If the Via is on=20
two lines like it is presented, then it is invalid. A header body can=20
continue on a new line, but it as to start with whitespace.

Regarding sanity, the module drops silently broken messages if you don't=20
set autodrop to 0:
http://kamailio.org/docs/modules/stable/modules/sanity.html#autodrop

Note that you need latest version of branch 3.1/master for it.

Cheers,
Daniel

On 11/11/10 1:50 PM, Morten Isaksen wrote:
> Hi,
>
> I narrowed it down to the sanity_check.
>
>         if(!sanity_check("1511", "7"))
>         {
>                 xlog("L_WARN", "sanity check - M=3D$rm RURI=3D$ru F=3D$fu
> T=3D$tu IP=3D$si ID=3D$ci\n");
>                 exit;
>         }
>
> The sanity_check fails but does not send a reply back or log the above
> line. I have commented it out and now the ACK is forwarded.
>
> /Morten
>
> On Mon, Nov 8, 2010 at 3:00 PM, Morten Isaksen<misak(a)misak.dk>  wrote:
>> Hi,
>>
>> On Fri, Oct 29, 2010 at 10:59 AM, Daniel-Constantin Mierla
>> <miconda(a)gmail.com>  wrote:
>>> Hello,
>>>
>>> On 10/28/10 1:37 PM, Morten Isaksen wrote:
>>>> Hi,
>>>>
>>>> I have a strange problem with Kamailio 3.0.2. When one of our end
>>>> users makes a call Kamailio does not route the ACK (in response to the
>>>> 200 OK). For all other end users it works fine.
>>>>
>>>> For me it looks the the has_totag() checks for some reason fails and
>>>> then t_check_trans() thinks it is a ACK to a local transactions and
>>>> then terminates the script. Otherwise there should be more lines in
>>>> the log file.
>>> if you add an xlog() after the if with has_totag(), do you get the message
>>> in the logs?
>>
>> Sorry for the delay, but a had to wait for the customer to make a test cal=
l.
>>
>> I placed a xlog("L_WARN", "has_totag after - M=3D$rm RURI=3D$ru F=3D$fu
>> T=3D$tu IP=3D$si ID=3D$ci\n"); just after the if (has_totag()) { .. } and =
it
>> does not show in the log.
>>
>> It looks very strange to me. Do you have any ideas what is wrong.
>>
>> /Morten
>>
>>> Cheers,
>>> Daniel
>>>
>>>> The conf is pretty standard.
>>>>
>>>> route{
>>>>
>>>>          xlog("L_WARN", "New request - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu
>>>> IP=3D$si ID=3D$ci\n");
>>>>          xlog("L_WARN", "ua=3D$ua");
>>>>          if (!mf_process_maxfwd_header("10")) {
>>>>                  sl_send_reply("483","Too Many Hops");
>>>>                  exit;
>>>>          }
>>>>
>>>>          if(!sanity_check("1511", "7"))
>>>>          {
>>>>                  xlog("Malformed SIP message from $si:$sp\n");
>>>>                  exit;
>>>>          }
>>>>
>>>>
>>>>          if (has_totag()) {
>>>>                  xlog("L_WARN", "has_totag start - M=3D$rm RURI=3D$ru F=
=3D$fu
>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>                  # sequential request withing a dialog should
>>>>                  # take the path determined by record-routing
>>>>                  if (loose_route()) {
>>>>                          xlog("L_WARN", "loose_route - M=3D$rm RURI=3D$ru
>>>> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>                          route(RELAY);
>>>>                  } else {
>>>>                          if (is_method("SUBSCRIBE")&&    uri =3D=3D myse=
lf) {
>>>>                                  # in-dialog subscribe requests
>>>>                                  #route(PRESENCE);
>>>>                                  exit;
>>>>                          }
>>>>                          if ( is_method("ACK") ) {
>>>>                                  if ( t_check_trans() ) {
>>>>                                          xlog("L_WARN", "ACK
>>>> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>                                          # non loose-route, but
>>>> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
>>>> server
>>>>                                          t_relay();
>>>>                                          exit;
>>>>                                  } else {
>>>>                                          xlog("Ignoring ACK - M=3D$rm
>>>> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>                                          # ACK without matching
>>>> transaction ... ignore and discard.\n");
>>>>                                          exit;
>>>>                                  }
>>>>                          }
>>>>                          sl_send_reply("404","Not here");
>>>>                  }
>>>>                  xlog("L_WARN", "has_totag end - M=3D$rm RURI=3D$ru F=3D=
$fu
>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>                  exit;
>>>>          }
>>>>
>>>>          #initial requests
>>>>
>>>>          # CANCEL processing
>>>>          if (is_method("CANCEL"))
>>>>          {
>>>>                  if (t_check_trans())
>>>>                          t_relay();
>>>>                  exit;
>>>>          }
>>>>
>>>>          setflag(4);
>>>>          t_check_trans();
>>>>
>>>> ...
>>>>
>>>> The log files show:
>>>>
>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
>>>> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
>>>> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20 ID=3DAI231CA9BD0A4A1C53(a)10.0=
.0.150
>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>> <script>: ua=3DAastra Intelligate
>>>>
>>>>
>>>>
>>>>
>>>> The trace
>>>>
>>>> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 ->    178.21.248.56:5060
>>>> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
>>>>
>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>.
>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Max-Forwards: 68.
>>>> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7>.
>>>> Accept: application/sdp.
>>>> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
>>>> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
>>>> Privacy: none.
>>>> User-Agent: Aastra Intelligate.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 280.
>>>> X-trunktype: IC.
>>>> .
>>>> v=3D0.
>>>> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
>>>> s=3Dcall.
>>>> c=3DIN IP4 178.21.248.22.
>>>> t=3D0 0.
>>>> m=3Daudio 60984 RTP/AVP 8 0 18 101.
>>>> a=3Drtpmap:8 PCMA/8000.
>>>> a=3Drtpmap:0 PCMU/8000.
>>>> a=3Drtpmap:18 G729/8000.
>>>> a=3Drtpmap:101 telephone-event/8000.
>>>> a=3Dfmtp:101 0-15.
>>>> a=3Dsendrecv.
>>>> a=3Dptime:20.
>>>>
>>>> #
>>>> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 ->    178.21.248.7:5060
>>>> SIP/2.0 100 Trying.
>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>> Allow:
>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE=
,UPDATE.
>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>> Content-Length: 0.
>>>> .
>>>>
>>>> #####
>>>> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 ->    178.21.248.7:5060
>>>> SIP/2.0 183 Session Progress.
>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>
>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>> Allow:
>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE=
,UPDATE.
>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 259.
>>>> .
>>>> v=3D0.
>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>> s=3DPhone-Call.
>>>> c=3DIN IP4 178.21.248.56.
>>>> t=3D0 0.
>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>> c=3DIN IP4 178.21.248.56.
>>>> a=3Drtpmap:8 PCMA/8000.
>>>> a=3Drtpmap:101 telephone-event/8000.
>>>> a=3Dfmtp:101 0-15.
>>>> a=3Dptime:20.
>>>> a=3Dsendrecv.
>>>>
>>>> #
>>>> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 ->    178.21.248.20:5060
>>>> SIP/2.0 183 Session Progress.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>
>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>> Allow:
>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE=
,UPDATE.
>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 259.
>>>> .
>>>> v=3D0.
>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>> s=3DPhone-Call.
>>>> c=3DIN IP4 178.21.248.56.
>>>> t=3D0 0.
>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>> c=3DIN IP4 178.21.248.56.
>>>> a=3Drtpmap:8 PCMA/8000.
>>>> a=3Drtpmap:101 telephone-event/8000.
>>>> a=3Dfmtp:101 0-15.
>>>> a=3Dptime:20.
>>>> a=3Dsendrecv.
>>>>
>>>> #
>>>> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 ->    178.21.248.7:5060
>>>> SIP/2.0 180 Ringing.
>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>
>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>> Allow:
>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE=
,UPDATE.
>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 259.
>>>> .
>>>> v=3D0.
>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>> s=3DPhone-Call.
>>>> c=3DIN IP4 178.21.248.56.
>>>> t=3D0 0.
>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>> c=3DIN IP4 178.21.248.56.
>>>> a=3Drtpmap:8 PCMA/8000.
>>>> a=3Drtpmap:101 telephone-event/8000.
>>>> a=3Dfmtp:101 0-15.
>>>> a=3Dptime:20.
>>>> a=3Dsendrecv.
>>>>
>>>> #
>>>> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 ->    178.21.248.20:5060
>>>> SIP/2.0 180 Ringing.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>
>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>> Allow:
>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE=
,UPDATE.
>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 259.
>>>> .
>>>> v=3D0.
>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>> s=3DPhone-Call.
>>>> c=3DIN IP4 178.21.248.56.
>>>> t=3D0 0.
>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>> c=3DIN IP4 178.21.248.56.
>>>> a=3Drtpmap:8 PCMA/8000.
>>>> a=3Drtpmap:101 telephone-event/8000.
>>>> a=3Dfmtp:101 0-15.
>>>> a=3Dptime:20.
>>>> a=3Dsendrecv.
>>>>
>>>> ##############################
>>>> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 ->    178.21.248.7:5060
>>>> SIP/2.0 200 OK.
>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>
>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>> Allow:
>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE=
,UPDATE.
>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 259.
>>>> .
>>>> v=3D0.
>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>> s=3DPhone-Call.
>>>> c=3DIN IP4 178.21.248.56.
>>>> t=3D0 0.
>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>> c=3DIN IP4 178.21.248.56.
>>>> a=3Drtpmap:8 PCMA/8000.
>>>> a=3Drtpmap:101 telephone-event/8000.
>>>> a=3Dfmtp:101 0-15.
>>>> a=3Dptime:20.
>>>> a=3Dsendrecv.
>>>>
>>>> #
>>>> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 ->    178.21.248.20:5060
>>>> SIP/2.0 200 OK.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c7=
82cc21592.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 INVITE.
>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>
>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>> Allow:
>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIBE=
,UPDATE.
>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>> Content-Type: application/sdp.
>>>> Content-Length: 259.
>>>> .
>>>> v=3D0.
>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>> s=3DPhone-Call.
>>>> c=3DIN IP4 178.21.248.56.
>>>> t=3D0 0.
>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>> c=3DIN IP4 178.21.248.56.
>>>> a=3Drtpmap:8 PCMA/8000.
>>>> a=3Drtpmap:101 telephone-event/8000.
>>>> a=3Dfmtp:101 0-15.
>>>> a=3Dptime:20.
>>>> a=3Dsendrecv.
>>>>
>>>> #####<<<<<<<<<<<<<<<<<<<<<<     This is the problem
>>>> packet>>>>>>>>>>>>>>>>>>>>>
>>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->    178.21.248.7:5060
>>>> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216=
eb2f7233f.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 ACK.
>>>> Max-Forwards: 69.
>>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>.
>>>> User-Agent: Aastra Intelligate.
>>>> Content-Length: 0.
>>>>
>>>>
>>>>
>>>>
>>>>
>>>>
>>>>
>>>>
>>> --
>>> Daniel-Constantin Mierla
>>> http://www.asipto.com
>>>
>>>
>>> _______________________________________________
>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>>> sr-users(a)lists.sip-router.org
>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>>
>>
>>
>> --
>> Morten Isaksen
>>
>
>

--=20
Daniel-Constantin Mierla
http://www.asipto.com



--===============1669116528==--


From misak@misak.dk Thu Nov 11 23:02:53 2010
From: Morten Isaksen <misak@misak.dk>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Thu, 11 Nov 2010 23:02:46 +0100
Message-ID: <AANLkTik6jxuVn7c2eamK87u1bNcVQONN7dK97tK0h5td@mail.gmail.com>
In-Reply-To: <4CDC41EA.5040001@gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1757235292=="

--===============1757235292==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hi Daniel,

The Via line is OK, it was the email formating.

I am using Kamailio 3.0.3 and the sanity docs says:

This function makes a row of sanity checks on the given request. The
function returns false (-1) if one of the checks failed. If one of the
checks fails the module sends a precise error reply via sl_send_reply.
Thus there is no need to reply with a generic error message.

I have solved the problem by removing the sanity_check.

I am just a bit curious why it failed.

But thank you very much for your help.

/Morten

On Thu, Nov 11, 2010 at 8:20 PM, Daniel-Constantin Mierla
<miconda(a)gmail.com> wrote:
> Hello,
>
> looking now again at the trace you sent first time, the ACK is:
>
> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 -> =C2=A0178.21.248.7:5060
> ACKsip:1105(a)178.21.248.56:5060 =C2=A0SIP/2.0.
> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
> Via: SIP/2.0/UDP
> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216eb2=
f7233f.
> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
> Call-ID:AI231CA9BD0A4A1C53(a)10.0.0.150.
> CSeq: 2 ACK.
> Max-Forwards: 69.
> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db0=
2>.
> User-Agent: Aastra Intelligate.
> Content-Length: 0.
>
> I thought that it may be the email body formatting so that the second Via
> header body gets on next line after SIP/2.0/UDP. Can you check your trace,
> is it on next line (i.e., there is a new line)? If the Via is on two lines
> like it is presented, then it is invalid. A header body can continue on a
> new line, but it as to start with whitespace.
>
> Regarding sanity, the module drops silently broken messages if you don't set
> autodrop to 0:
> http://kamailio.org/docs/modules/stable/modules/sanity.html#autodrop
>
> Note that you need latest version of branch 3.1/master for it.
>
> Cheers,
> Daniel
>
> On 11/11/10 1:50 PM, Morten Isaksen wrote:
>>
>> Hi,
>>
>> I narrowed it down to the sanity_check.
>>
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0if(!sanity_check("1511", "7"))
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0{
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0xlog("L_WARN", "san=
ity check - M=3D$rm RURI=3D$ru F=3D$fu
>> T=3D$tu IP=3D$si ID=3D$ci\n");
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0exit;
>> =C2=A0 =C2=A0 =C2=A0 =C2=A0}
>>
>> The sanity_check fails but does not send a reply back or log the above
>> line. I have commented it out and now the ACK is forwarded.
>>
>> /Morten
>>
>> On Mon, Nov 8, 2010 at 3:00 PM, Morten Isaksen<misak(a)misak.dk> =C2=A0wro=
te:
>>>
>>> Hi,
>>>
>>> On Fri, Oct 29, 2010 at 10:59 AM, Daniel-Constantin Mierla
>>> <miconda(a)gmail.com> =C2=A0wrote:
>>>>
>>>> Hello,
>>>>
>>>> On 10/28/10 1:37 PM, Morten Isaksen wrote:
>>>>>
>>>>> Hi,
>>>>>
>>>>> I have a strange problem with Kamailio 3.0.2. When one of our end
>>>>> users makes a call Kamailio does not route the ACK (in response to the
>>>>> 200 OK). For all other end users it works fine.
>>>>>
>>>>> For me it looks the the has_totag() checks for some reason fails and
>>>>> then t_check_trans() thinks it is a ACK to a local transactions and
>>>>> then terminates the script. Otherwise there should be more lines in
>>>>> the log file.
>>>>
>>>> if you add an xlog() after the if with has_totag(), do you get the
>>>> message
>>>> in the logs?
>>>
>>> Sorry for the delay, but a had to wait for the customer to make a test
>>> call.
>>>
>>> I placed a xlog("L_WARN", "has_totag after - M=3D$rm RURI=3D$ru F=3D$fu
>>> T=3D$tu IP=3D$si ID=3D$ci\n"); just after the if (has_totag()) { .. } and=
 it
>>> does not show in the log.
>>>
>>> It looks very strange to me. Do you have any ideas what is wrong.
>>>
>>> /Morten
>>>
>>>> Cheers,
>>>> Daniel
>>>>
>>>>> The conf is pretty standard.
>>>>>
>>>>> route{
>>>>>
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "New request - M=3D$rm RURI=
=3D$ru F=3D$fu T=3D$tu
>>>>> IP=3D$si ID=3D$ci\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "ua=3D$ua");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (!mf_process_maxfwd_header("10")) {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 sl_send_reply("=
483","Too Many Hops");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if(!sanity_check("1511", "7"))
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("Malformed=
 SIP message from $si:$sp\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>
>>>>>
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (has_totag()) {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", =
"has_totag start - M=3D$rm RURI=3D$ru F=3D$fu
>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # sequential re=
quest withing a dialog should
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # take the path=
 determined by record-routing
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (loose_route=
()) {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 xlog("L_WARN", "loose_route - M=3D$rm RURI=3D$ru
>>>>> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 route(RELAY);
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 if (is_method("SUBSCRIBE")&& =C2=A0 =C2=A0uri =3D=3D myself)
>>>>> {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # in-dialog subscribe requests
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 #route(PRESENCE);
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 }
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 if ( is_method("ACK") ) {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if ( t_check_trans() ) {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L=
_WARN", "ACK
>>>>> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n"=
);
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # non l=
oose-route, but
>>>>> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
>>>>> server
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_relay=
();
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("I=
gnoring ACK - M=3D$rm
>>>>> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # ACK w=
ithout matching
>>>>> transaction ... ignore and discard.\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 }
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 sl_send_reply("404","Not here");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", =
"has_totag end - M=3D$rm RURI=3D$ru F=3D$fu
>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 #initial requests
>>>>>
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 # CANCEL processing
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (is_method("CANCEL"))
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (t_check_tra=
ns())
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 t_relay();
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 setflag(4);
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_check_trans();
>>>>>
>>>>> ...
>>>>>
>>>>> The log files show:
>>>>>
>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>>> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
>>>>> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
>>>>> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20 ID=3DAI231CA9BD0A4A1C53(a)10.=
0.0.150
>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>>> <script>: ua=3DAastra Intelligate
>>>>>
>>>>>
>>>>>
>>>>>
>>>>> The trace
>>>>>
>>>>> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 -> =C2=A0 =C2=A0178.21.2=
48.56:5060
>>>>> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
>>>>>
>>>>>
>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>.
>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Max-Forwards: 68.
>>>>> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7>.
>>>>> Accept: application/sdp.
>>>>> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
>>>>> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
>>>>> Privacy: none.
>>>>> User-Agent: Aastra Intelligate.
>>>>> Content-Type: application/sdp.
>>>>> Content-Length: 280.
>>>>> X-trunktype: IC.
>>>>> .
>>>>> v=3D0.
>>>>> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
>>>>> s=3Dcall.
>>>>> c=3DIN IP4 178.21.248.22.
>>>>> t=3D0 0.
>>>>> m=3Daudio 60984 RTP/AVP 8 0 18 101.
>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>> a=3Drtpmap:0 PCMU/8000.
>>>>> a=3Drtpmap:18 G729/8000.
>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>> a=3Dfmtp:101 0-15.
>>>>> a=3Dsendrecv.
>>>>> a=3Dptime:20.
>>>>>
>>>>> #
>>>>> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 -> =C2=A0 =C2=A0178.21.=
248.7:5060
>>>>> SIP/2.0 100 Trying.
>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>> Allow:
>>>>>
>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIB=
E,UPDATE.
>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>> Content-Length: 0.
>>>>> .
>>>>>
>>>>> #####
>>>>> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 -> =C2=A0 =C2=A0178.21.=
248.7:5060
>>>>> SIP/2.0 183 Session Progress.
>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>
>>>>>
>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>> Allow:
>>>>>
>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIB=
E,UPDATE.
>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>> Content-Type: application/sdp.
>>>>> Content-Length: 259.
>>>>> .
>>>>> v=3D0.
>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>> s=3DPhone-Call.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> t=3D0 0.
>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>> a=3Dfmtp:101 0-15.
>>>>> a=3Dptime:20.
>>>>> a=3Dsendrecv.
>>>>>
>>>>> #
>>>>> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 -> =C2=A0 =C2=A0178.21.2=
48.20:5060
>>>>> SIP/2.0 183 Session Progress.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>
>>>>>
>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>> Allow:
>>>>>
>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIB=
E,UPDATE.
>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>> Content-Type: application/sdp.
>>>>> Content-Length: 259.
>>>>> .
>>>>> v=3D0.
>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>> s=3DPhone-Call.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> t=3D0 0.
>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>> a=3Dfmtp:101 0-15.
>>>>> a=3Dptime:20.
>>>>> a=3Dsendrecv.
>>>>>
>>>>> #
>>>>> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 -> =C2=A0 =C2=A0178.21.=
248.7:5060
>>>>> SIP/2.0 180 Ringing.
>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>
>>>>>
>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>> Allow:
>>>>>
>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIB=
E,UPDATE.
>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>> Content-Type: application/sdp.
>>>>> Content-Length: 259.
>>>>> .
>>>>> v=3D0.
>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>> s=3DPhone-Call.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> t=3D0 0.
>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>> a=3Dfmtp:101 0-15.
>>>>> a=3Dptime:20.
>>>>> a=3Dsendrecv.
>>>>>
>>>>> #
>>>>> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 -> =C2=A0 =C2=A0178.21.2=
48.20:5060
>>>>> SIP/2.0 180 Ringing.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>
>>>>>
>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>> Allow:
>>>>>
>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIB=
E,UPDATE.
>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>> Content-Type: application/sdp.
>>>>> Content-Length: 259.
>>>>> .
>>>>> v=3D0.
>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>> s=3DPhone-Call.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> t=3D0 0.
>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>> a=3Dfmtp:101 0-15.
>>>>> a=3Dptime:20.
>>>>> a=3Dsendrecv.
>>>>>
>>>>> ##############################
>>>>> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 -> =C2=A0 =C2=A0178.21.=
248.7:5060
>>>>> SIP/2.0 200 OK.
>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>
>>>>>
>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>> Allow:
>>>>>
>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIB=
E,UPDATE.
>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>> Content-Type: application/sdp.
>>>>> Content-Length: 259.
>>>>> .
>>>>> v=3D0.
>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>> s=3DPhone-Call.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> t=3D0 0.
>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>> a=3Dfmtp:101 0-15.
>>>>> a=3Dptime:20.
>>>>> a=3Dsendrecv.
>>>>>
>>>>> #
>>>>> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 -> =C2=A0 =C2=A0178.21.2=
48.20:5060
>>>>> SIP/2.0 200 OK.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6c=
782cc21592.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 INVITE.
>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>
>>>>>
>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>> Allow:
>>>>>
>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRIB=
E,UPDATE.
>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>> Content-Type: application/sdp.
>>>>> Content-Length: 259.
>>>>> .
>>>>> v=3D0.
>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>> s=3DPhone-Call.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> t=3D0 0.
>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>> c=3DIN IP4 178.21.248.56.
>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>> a=3Dfmtp:101 0-15.
>>>>> a=3Dptime:20.
>>>>> a=3Dsendrecv.
>>>>>
>>>>> #####<<<<<<<<<<<<<<<<<<<<<< =C2=A0 =C2=A0 This is the problem
>>>>> packet>>>>>>>>>>>>>>>>>>>>>
>>>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 -> =C2=A0 =C2=A0178.21.=
248.7:5060
>>>>> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>>>> Via: SIP/2.0/UDP
>>>>>
>>>>>
>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b821=
6eb2f7233f.
>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>> CSeq: 2 ACK.
>>>>> Max-Forwards: 69.
>>>>>
>>>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd=
1db02>.
>>>>> User-Agent: Aastra Intelligate.
>>>>> Content-Length: 0.
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>>>
>>>> --
>>>> Daniel-Constantin Mierla
>>>> http://www.asipto.com
>>>>
>>>>
>>>> _______________________________________________
>>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>>>> sr-users(a)lists.sip-router.org
>>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>>>
>>>
>>>
>>> --
>>> Morten Isaksen
>>>
>>
>>
>
> --
> Daniel-Constantin Mierla
> http://www.asipto.com
>
>
> _______________________________________________
> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
> sr-users(a)lists.sip-router.org
> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>



--=20
Morten Isaksen


--===============1757235292==--


From miconda@gmail.com Thu Nov 11 23:28:21 2010
From: Daniel-Constantin Mierla <miconda@gmail.com>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Thu, 11 Nov 2010 23:28:17 +0100
Message-ID: <4CDC6E01.1030305@gmail.com>
In-Reply-To: <AANLkTik6jxuVn7c2eamK87u1bNcVQONN7dK97tK0h5td@mail.gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1061972864=="

--===============1061972864==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hello,

On 11/11/10 11:02 PM, Morten Isaksen wrote:
> Hi Daniel,
>
> The Via line is OK, it was the email formating.
>
> I am using Kamailio 3.0.3 and the sanity docs says:
>
> This function makes a row of sanity checks on the given request. The
> function returns false (-1) if one of the checks failed. If one of the
> checks fails the module sends a precise error reply via sl_send_reply.
> Thus there is no need to reply with a generic error message.
it happens sometime that some module parameters control the behavior of=20
exported functions and it is not mentioned in description. This one was=20
discovered pretty recently and the description of sanity_check() don't=20
refer to autodrop parameter. I will try to update asap.

> I have solved the problem by removing the sanity_check.
>
> I am just a bit curious why it failed.

That should be found to see where is the failure. As a second guess=20
based on checks, it may be that the ACK has some whitespace in the body.=20
Do you have pcap version of this ACK trace?

Daniel

> But thank you very much for your help.
>
> /Morten
>
> On Thu, Nov 11, 2010 at 8:20 PM, Daniel-Constantin Mierla
> <miconda(a)gmail.com>  wrote:
>> Hello,
>>
>> looking now again at the trace you sent first time, the ACK is:
>>
>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->    178.21.248.7:5060
>> ACKsip:1105(a)178.21.248.56:5060  SIP/2.0.
>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>> Via: SIP/2.0/UDP
>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216eb=
2f7233f.
>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>> Call-ID:AI231CA9BD0A4A1C53(a)10.0.0.150.
>> CSeq: 2 ACK.
>> Max-Forwards: 69.
>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1db=
02>.
>> User-Agent: Aastra Intelligate.
>> Content-Length: 0.
>>
>> I thought that it may be the email body formatting so that the second Via
>> header body gets on next line after SIP/2.0/UDP. Can you check your trace,
>> is it on next line (i.e., there is a new line)? If the Via is on two lines
>> like it is presented, then it is invalid. A header body can continue on a
>> new line, but it as to start with whitespace.
>>
>> Regarding sanity, the module drops silently broken messages if you don't s=
et
>> autodrop to 0:
>> http://kamailio.org/docs/modules/stable/modules/sanity.html#autodrop
>>
>> Note that you need latest version of branch 3.1/master for it.
>>
>> Cheers,
>> Daniel
>>
>> On 11/11/10 1:50 PM, Morten Isaksen wrote:
>>> Hi,
>>>
>>> I narrowed it down to the sanity_check.
>>>
>>>         if(!sanity_check("1511", "7"))
>>>         {
>>>                 xlog("L_WARN", "sanity check - M=3D$rm RURI=3D$ru F=3D$fu
>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>                 exit;
>>>         }
>>>
>>> The sanity_check fails but does not send a reply back or log the above
>>> line. I have commented it out and now the ACK is forwarded.
>>>
>>> /Morten
>>>
>>> On Mon, Nov 8, 2010 at 3:00 PM, Morten Isaksen<misak(a)misak.dk>    wrote:
>>>> Hi,
>>>>
>>>> On Fri, Oct 29, 2010 at 10:59 AM, Daniel-Constantin Mierla
>>>> <miconda(a)gmail.com>    wrote:
>>>>> Hello,
>>>>>
>>>>> On 10/28/10 1:37 PM, Morten Isaksen wrote:
>>>>>> Hi,
>>>>>>
>>>>>> I have a strange problem with Kamailio 3.0.2. When one of our end
>>>>>> users makes a call Kamailio does not route the ACK (in response to the
>>>>>> 200 OK). For all other end users it works fine.
>>>>>>
>>>>>> For me it looks the the has_totag() checks for some reason fails and
>>>>>> then t_check_trans() thinks it is a ACK to a local transactions and
>>>>>> then terminates the script. Otherwise there should be more lines in
>>>>>> the log file.
>>>>> if you add an xlog() after the if with has_totag(), do you get the
>>>>> message
>>>>> in the logs?
>>>> Sorry for the delay, but a had to wait for the customer to make a test
>>>> call.
>>>>
>>>> I placed a xlog("L_WARN", "has_totag after - M=3D$rm RURI=3D$ru F=3D$fu
>>>> T=3D$tu IP=3D$si ID=3D$ci\n"); just after the if (has_totag()) { .. } an=
d it
>>>> does not show in the log.
>>>>
>>>> It looks very strange to me. Do you have any ideas what is wrong.
>>>>
>>>> /Morten
>>>>
>>>>> Cheers,
>>>>> Daniel
>>>>>
>>>>>> The conf is pretty standard.
>>>>>>
>>>>>> route{
>>>>>>
>>>>>>          xlog("L_WARN", "New request - M=3D$rm RURI=3D$ru F=3D$fu T=3D=
$tu
>>>>>> IP=3D$si ID=3D$ci\n");
>>>>>>          xlog("L_WARN", "ua=3D$ua");
>>>>>>          if (!mf_process_maxfwd_header("10")) {
>>>>>>                  sl_send_reply("483","Too Many Hops");
>>>>>>                  exit;
>>>>>>          }
>>>>>>
>>>>>>          if(!sanity_check("1511", "7"))
>>>>>>          {
>>>>>>                  xlog("Malformed SIP message from $si:$sp\n");
>>>>>>                  exit;
>>>>>>          }
>>>>>>
>>>>>>
>>>>>>          if (has_totag()) {
>>>>>>                  xlog("L_WARN", "has_totag start - M=3D$rm RURI=3D$ru =
F=3D$fu
>>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>                  # sequential request withing a dialog should
>>>>>>                  # take the path determined by record-routing
>>>>>>                  if (loose_route()) {
>>>>>>                          xlog("L_WARN", "loose_route - M=3D$rm RURI=3D=
$ru
>>>>>> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>                          route(RELAY);
>>>>>>                  } else {
>>>>>>                          if (is_method("SUBSCRIBE")&&      uri =3D=3D =
myself)
>>>>>> {
>>>>>>                                  # in-dialog subscribe requests
>>>>>>                                  #route(PRESENCE);
>>>>>>                                  exit;
>>>>>>                          }
>>>>>>                          if ( is_method("ACK") ) {
>>>>>>                                  if ( t_check_trans() ) {
>>>>>>                                          xlog("L_WARN", "ACK
>>>>>> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n=
");
>>>>>>                                          # non loose-route, but
>>>>>> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
>>>>>> server
>>>>>>                                          t_relay();
>>>>>>                                          exit;
>>>>>>                                  } else {
>>>>>>                                          xlog("Ignoring ACK - M=3D$rm
>>>>>> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>                                          # ACK without matching
>>>>>> transaction ... ignore and discard.\n");
>>>>>>                                          exit;
>>>>>>                                  }
>>>>>>                          }
>>>>>>                          sl_send_reply("404","Not here");
>>>>>>                  }
>>>>>>                  xlog("L_WARN", "has_totag end - M=3D$rm RURI=3D$ru F=
=3D$fu
>>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>                  exit;
>>>>>>          }
>>>>>>
>>>>>>          #initial requests
>>>>>>
>>>>>>          # CANCEL processing
>>>>>>          if (is_method("CANCEL"))
>>>>>>          {
>>>>>>                  if (t_check_trans())
>>>>>>                          t_relay();
>>>>>>                  exit;
>>>>>>          }
>>>>>>
>>>>>>          setflag(4);
>>>>>>          t_check_trans();
>>>>>>
>>>>>> ...
>>>>>>
>>>>>> The log files show:
>>>>>>
>>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>>>> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
>>>>>> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
>>>>>> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20 ID=3DAI231CA9BD0A4A1C53(a)10=
.0.0.150
>>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>>>> <script>: ua=3DAastra Intelligate
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>> The trace
>>>>>>
>>>>>> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 ->      178.21.248.56:5=
060
>>>>>> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
>>>>>>
>>>>>>
>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>.
>>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Max-Forwards: 68.
>>>>>> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7>.
>>>>>> Accept: application/sdp.
>>>>>> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
>>>>>> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
>>>>>> Privacy: none.
>>>>>> User-Agent: Aastra Intelligate.
>>>>>> Content-Type: application/sdp.
>>>>>> Content-Length: 280.
>>>>>> X-trunktype: IC.
>>>>>> .
>>>>>> v=3D0.
>>>>>> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
>>>>>> s=3Dcall.
>>>>>> c=3DIN IP4 178.21.248.22.
>>>>>> t=3D0 0.
>>>>>> m=3Daudio 60984 RTP/AVP 8 0 18 101.
>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>> a=3Drtpmap:0 PCMU/8000.
>>>>>> a=3Drtpmap:18 G729/8000.
>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>> a=3Dfmtp:101 0-15.
>>>>>> a=3Dsendrecv.
>>>>>> a=3Dptime:20.
>>>>>>
>>>>>> #
>>>>>> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 ->      178.21.248.7:5=
060
>>>>>> SIP/2.0 100 Trying.
>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>> Allow:
>>>>>>
>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>> Content-Length: 0.
>>>>>> .
>>>>>>
>>>>>> #####
>>>>>> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 ->      178.21.248.7:5=
060
>>>>>> SIP/2.0 183 Session Progress.
>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>
>>>>>>
>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>> Allow:
>>>>>>
>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>> Content-Type: application/sdp.
>>>>>> Content-Length: 259.
>>>>>> .
>>>>>> v=3D0.
>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>> s=3DPhone-Call.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> t=3D0 0.
>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>> a=3Dfmtp:101 0-15.
>>>>>> a=3Dptime:20.
>>>>>> a=3Dsendrecv.
>>>>>>
>>>>>> #
>>>>>> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 ->      178.21.248.20:5=
060
>>>>>> SIP/2.0 183 Session Progress.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>
>>>>>>
>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>> Allow:
>>>>>>
>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>> Content-Type: application/sdp.
>>>>>> Content-Length: 259.
>>>>>> .
>>>>>> v=3D0.
>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>> s=3DPhone-Call.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> t=3D0 0.
>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>> a=3Dfmtp:101 0-15.
>>>>>> a=3Dptime:20.
>>>>>> a=3Dsendrecv.
>>>>>>
>>>>>> #
>>>>>> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 ->      178.21.248.7:5=
060
>>>>>> SIP/2.0 180 Ringing.
>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>
>>>>>>
>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>> Allow:
>>>>>>
>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>> Content-Type: application/sdp.
>>>>>> Content-Length: 259.
>>>>>> .
>>>>>> v=3D0.
>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>> s=3DPhone-Call.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> t=3D0 0.
>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>> a=3Dfmtp:101 0-15.
>>>>>> a=3Dptime:20.
>>>>>> a=3Dsendrecv.
>>>>>>
>>>>>> #
>>>>>> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 ->      178.21.248.20:5=
060
>>>>>> SIP/2.0 180 Ringing.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>
>>>>>>
>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>> Allow:
>>>>>>
>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>> Content-Type: application/sdp.
>>>>>> Content-Length: 259.
>>>>>> .
>>>>>> v=3D0.
>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>> s=3DPhone-Call.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> t=3D0 0.
>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>> a=3Dfmtp:101 0-15.
>>>>>> a=3Dptime:20.
>>>>>> a=3Dsendrecv.
>>>>>>
>>>>>> ##############################
>>>>>> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 ->      178.21.248.7:5=
060
>>>>>> SIP/2.0 200 OK.
>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>
>>>>>>
>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>> Allow:
>>>>>>
>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>> Content-Type: application/sdp.
>>>>>> Content-Length: 259.
>>>>>> .
>>>>>> v=3D0.
>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>> s=3DPhone-Call.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> t=3D0 0.
>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>> a=3Dfmtp:101 0-15.
>>>>>> a=3Dptime:20.
>>>>>> a=3Dsendrecv.
>>>>>>
>>>>>> #
>>>>>> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 ->      178.21.248.20:5=
060
>>>>>> SIP/2.0 200 OK.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e6=
c782cc21592.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 INVITE.
>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>
>>>>>>
>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>> Allow:
>>>>>>
>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCRI=
BE,UPDATE.
>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>> Content-Type: application/sdp.
>>>>>> Content-Length: 259.
>>>>>> .
>>>>>> v=3D0.
>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>> s=3DPhone-Call.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> t=3D0 0.
>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>> a=3Dfmtp:101 0-15.
>>>>>> a=3Dptime:20.
>>>>>> a=3Dsendrecv.
>>>>>>
>>>>>> #####<<<<<<<<<<<<<<<<<<<<<<       This is the problem
>>>>>> packet>>>>>>>>>>>>>>>>>>>>>
>>>>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->      178.21.248.7:5=
060
>>>>>> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
>>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>>>>> Via: SIP/2.0/UDP
>>>>>>
>>>>>>
>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b82=
16eb2f7233f.
>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>> CSeq: 2 ACK.
>>>>>> Max-Forwards: 69.
>>>>>>
>>>>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5f=
d1db02>.
>>>>>> User-Agent: Aastra Intelligate.
>>>>>> Content-Length: 0.
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>>>
>>>>> --
>>>>> Daniel-Constantin Mierla
>>>>> http://www.asipto.com
>>>>>
>>>>>
>>>>> _______________________________________________
>>>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>>>>> sr-users(a)lists.sip-router.org
>>>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>>>>
>>>>
>>>> --
>>>> Morten Isaksen
>>>>
>>>
>> --
>> Daniel-Constantin Mierla
>> http://www.asipto.com
>>
>>
>> _______________________________________________
>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>> sr-users(a)lists.sip-router.org
>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>
>
>

--=20
Daniel-Constantin Mierla
http://www.asipto.com



--===============1061972864==--


From miconda@gmail.com Mon Nov 15 16:22:10 2010
From: Daniel-Constantin Mierla <miconda@gmail.com>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Mon, 15 Nov 2010 16:22:00 +0100
Message-ID: <4CE15018.7060808@gmail.com>
In-Reply-To: <4CDC6E01.1030305@gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1201106611=="

--===============1201106611==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hello,

I got the pcap file and had the time too check it. There seems to be an=20
extra LF at the end of ACK:

0230  73 65 72 2d 41 67 65 6e  74 3a 20 41 61 73 74 72   ser-Agen t: Aastr
0240  61 20 49 6e 74 65 6c 6c  69 67 61 74 65 0d 0a 43   a Intell igate..C
0250  6f 6e 74 65 6e 74 2d 4c  65 6e 67 74 68 3a 20 30   ontent-L ength: 0
0260  0d 0a 0d 0a 0a                                     .....

Once the last header is finished and ended with CRLF, there must be=20
another CRLF and that's it if content length is 0.

According to wireshark and the capture you sent, there is an extra 0x0a=20
(LF), so instead of ending in CRLFCRLF, the ACK ends in CRLFCRLFLF

You can remove the content-length check in sanity function, but I=20
recomend you report to vendor to get the issue fixed there.

Cheers,
Daniel


On 11/11/10 11:28 PM, Daniel-Constantin Mierla wrote:
> Hello,
>
> On 11/11/10 11:02 PM, Morten Isaksen wrote:
>> Hi Daniel,
>>
>> The Via line is OK, it was the email formating.
>>
>> I am using Kamailio 3.0.3 and the sanity docs says:
>>
>> This function makes a row of sanity checks on the given request. The
>> function returns false (-1) if one of the checks failed. If one of the
>> checks fails the module sends a precise error reply via sl_send_reply.
>> Thus there is no need to reply with a generic error message.
> it happens sometime that some module parameters control the behavior=20
> of exported functions and it is not mentioned in description. This one=20
> was discovered pretty recently and the description of sanity_check()=20
> don't refer to autodrop parameter. I will try to update asap.
>
>> I have solved the problem by removing the sanity_check.
>>
>> I am just a bit curious why it failed.
>
> That should be found to see where is the failure. As a second guess=20
> based on checks, it may be that the ACK has some whitespace in the=20
> body. Do you have pcap version of this ACK trace?
>
> Daniel
>
>> But thank you very much for your help.
>>
>> /Morten
>>
>> On Thu, Nov 11, 2010 at 8:20 PM, Daniel-Constantin Mierla
>> <miconda(a)gmail.com>  wrote:
>>> Hello,
>>>
>>> looking now again at the trace you sent first time, the ACK is:
>>>
>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->    178.21.248.7:5060
>>> ACKsip:1105(a)178.21.248.56:5060  SIP/2.0.
>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>> Via: SIP/2.0/UDP
>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216e=
b2f7233f.=20
>>>
>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>> Call-ID:AI231CA9BD0A4A1C53(a)10.0.0.150.
>>> CSeq: 2 ACK.
>>> Max-Forwards: 69.
>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1d=
b02>.=20
>>>
>>> User-Agent: Aastra Intelligate.
>>> Content-Length: 0.
>>>
>>> I thought that it may be the email body formatting so that the=20
>>> second Via
>>> header body gets on next line after SIP/2.0/UDP. Can you check your=20
>>> trace,
>>> is it on next line (i.e., there is a new line)? If the Via is on two=20
>>> lines
>>> like it is presented, then it is invalid. A header body can continue=20
>>> on a
>>> new line, but it as to start with whitespace.
>>>
>>> Regarding sanity, the module drops silently broken messages if you=20
>>> don't set
>>> autodrop to 0:
>>> http://kamailio.org/docs/modules/stable/modules/sanity.html#autodrop
>>>
>>> Note that you need latest version of branch 3.1/master for it.
>>>
>>> Cheers,
>>> Daniel
>>>
>>> On 11/11/10 1:50 PM, Morten Isaksen wrote:
>>>> Hi,
>>>>
>>>> I narrowed it down to the sanity_check.
>>>>
>>>>         if(!sanity_check("1511", "7"))
>>>>         {
>>>>                 xlog("L_WARN", "sanity check - M=3D$rm RURI=3D$ru F=3D$fu
>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>                 exit;
>>>>         }
>>>>
>>>> The sanity_check fails but does not send a reply back or log the above
>>>> line. I have commented it out and now the ACK is forwarded.
>>>>
>>>> /Morten
>>>>
>>>> On Mon, Nov 8, 2010 at 3:00 PM, Morten Isaksen<misak(a)misak.dk>   =20
>>>> wrote:
>>>>> Hi,
>>>>>
>>>>> On Fri, Oct 29, 2010 at 10:59 AM, Daniel-Constantin Mierla
>>>>> <miconda(a)gmail.com>    wrote:
>>>>>> Hello,
>>>>>>
>>>>>> On 10/28/10 1:37 PM, Morten Isaksen wrote:
>>>>>>> Hi,
>>>>>>>
>>>>>>> I have a strange problem with Kamailio 3.0.2. When one of our end
>>>>>>> users makes a call Kamailio does not route the ACK (in response=20
>>>>>>> to the
>>>>>>> 200 OK). For all other end users it works fine.
>>>>>>>
>>>>>>> For me it looks the the has_totag() checks for some reason fails=20
>>>>>>> and
>>>>>>> then t_check_trans() thinks it is a ACK to a local transactions and
>>>>>>> then terminates the script. Otherwise there should be more lines in
>>>>>>> the log file.
>>>>>> if you add an xlog() after the if with has_totag(), do you get the
>>>>>> message
>>>>>> in the logs?
>>>>> Sorry for the delay, but a had to wait for the customer to make a=20
>>>>> test
>>>>> call.
>>>>>
>>>>> I placed a xlog("L_WARN", "has_totag after - M=3D$rm RURI=3D$ru F=3D$fu
>>>>> T=3D$tu IP=3D$si ID=3D$ci\n"); just after the if (has_totag()) { .. }=20
>>>>> and it
>>>>> does not show in the log.
>>>>>
>>>>> It looks very strange to me. Do you have any ideas what is wrong.
>>>>>
>>>>> /Morten
>>>>>
>>>>>> Cheers,
>>>>>> Daniel
>>>>>>
>>>>>>> The conf is pretty standard.
>>>>>>>
>>>>>>> route{
>>>>>>>
>>>>>>>          xlog("L_WARN", "New request - M=3D$rm RURI=3D$ru F=3D$fu T=
=3D$tu
>>>>>>> IP=3D$si ID=3D$ci\n");
>>>>>>>          xlog("L_WARN", "ua=3D$ua");
>>>>>>>          if (!mf_process_maxfwd_header("10")) {
>>>>>>>                  sl_send_reply("483","Too Many Hops");
>>>>>>>                  exit;
>>>>>>>          }
>>>>>>>
>>>>>>>          if(!sanity_check("1511", "7"))
>>>>>>>          {
>>>>>>>                  xlog("Malformed SIP message from $si:$sp\n");
>>>>>>>                  exit;
>>>>>>>          }
>>>>>>>
>>>>>>>
>>>>>>>          if (has_totag()) {
>>>>>>>                  xlog("L_WARN", "has_totag start - M=3D$rm=20
>>>>>>> RURI=3D$ru F=3D$fu
>>>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>                  # sequential request withing a dialog should
>>>>>>>                  # take the path determined by record-routing
>>>>>>>                  if (loose_route()) {
>>>>>>>                          xlog("L_WARN", "loose_route - M=3D$rm=20
>>>>>>> RURI=3D$ru
>>>>>>> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>                          route(RELAY);
>>>>>>>                  } else {
>>>>>>>                          if (is_method("SUBSCRIBE")&&      uri=20
>>>>>>> =3D=3D myself)
>>>>>>> {
>>>>>>>                                  # in-dialog subscribe requests
>>>>>>>                                  #route(PRESENCE);
>>>>>>>                                  exit;
>>>>>>>                          }
>>>>>>>                          if ( is_method("ACK") ) {
>>>>>>>                                  if ( t_check_trans() ) {
>>>>>>>                                          xlog("L_WARN", "ACK
>>>>>>> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\=
n");
>>>>>>>                                          # non loose-route, but
>>>>>>> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
>>>>>>> server
>>>>>>>                                          t_relay();
>>>>>>>                                          exit;
>>>>>>>                                  } else {
>>>>>>>                                          xlog("Ignoring ACK - M=3D$rm
>>>>>>> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>                                          # ACK without matching
>>>>>>> transaction ... ignore and discard.\n");
>>>>>>>                                          exit;
>>>>>>>                                  }
>>>>>>>                          }
>>>>>>>                          sl_send_reply("404","Not here");
>>>>>>>                  }
>>>>>>>                  xlog("L_WARN", "has_totag end - M=3D$rm RURI=3D$ru=20
>>>>>>> F=3D$fu
>>>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>                  exit;
>>>>>>>          }
>>>>>>>
>>>>>>>          #initial requests
>>>>>>>
>>>>>>>          # CANCEL processing
>>>>>>>          if (is_method("CANCEL"))
>>>>>>>          {
>>>>>>>                  if (t_check_trans())
>>>>>>>                          t_relay();
>>>>>>>                  exit;
>>>>>>>          }
>>>>>>>
>>>>>>>          setflag(4);
>>>>>>>          t_check_trans();
>>>>>>>
>>>>>>> ...
>>>>>>>
>>>>>>> The log files show:
>>>>>>>
>>>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]:=20
>>>>>>> WARNING:
>>>>>>> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
>>>>>>> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
>>>>>>> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20=20
>>>>>>> ID=3DAI231CA9BD0A4A1C53(a)10.0.0.150
>>>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]:=20
>>>>>>> WARNING:
>>>>>>> <script>: ua=3DAastra Intelligate
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>> The trace
>>>>>>>
>>>>>>> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 ->     =20
>>>>>>> 178.21.248.56:5060
>>>>>>> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
>>>>>>>
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48=
.5fd1db02>.=20
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>.
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Max-Forwards: 68.
>>>>>>> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD7=
>.
>>>>>>> Accept: application/sdp.
>>>>>>> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
>>>>>>> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
>>>>>>> Privacy: none.
>>>>>>> User-Agent: Aastra Intelligate.
>>>>>>> Content-Type: application/sdp.
>>>>>>> Content-Length: 280.
>>>>>>> X-trunktype: IC.
>>>>>>> .
>>>>>>> v=3D0.
>>>>>>> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
>>>>>>> s=3Dcall.
>>>>>>> c=3DIN IP4 178.21.248.22.
>>>>>>> t=3D0 0.
>>>>>>> m=3Daudio 60984 RTP/AVP 8 0 18 101.
>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>> a=3Drtpmap:0 PCMU/8000.
>>>>>>> a=3Drtpmap:18 G729/8000.
>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>> a=3Dsendrecv.
>>>>>>> a=3Dptime:20.
>>>>>>>
>>>>>>> #
>>>>>>> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 ->     =20
>>>>>>> 178.21.248.7:5060
>>>>>>> SIP/2.0 100 Trying.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>> Allow:
>>>>>>>
>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCR=
IBE,UPDATE.=20
>>>>>>>
>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>> Content-Length: 0.
>>>>>>> .
>>>>>>>
>>>>>>> #####
>>>>>>> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 ->     =20
>>>>>>> 178.21.248.7:5060
>>>>>>> SIP/2.0 183 Session Progress.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48=
.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.=20
>>>>>>>
>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>> Allow:
>>>>>>>
>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCR=
IBE,UPDATE.=20
>>>>>>>
>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>> Content-Type: application/sdp.
>>>>>>> Content-Length: 259.
>>>>>>> .
>>>>>>> v=3D0.
>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>> s=3DPhone-Call.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> t=3D0 0.
>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>> a=3Dptime:20.
>>>>>>> a=3Dsendrecv.
>>>>>>>
>>>>>>> #
>>>>>>> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 ->     =20
>>>>>>> 178.21.248.20:5060
>>>>>>> SIP/2.0 183 Session Progress.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48=
.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.=20
>>>>>>>
>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>> Allow:
>>>>>>>
>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCR=
IBE,UPDATE.=20
>>>>>>>
>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>> Content-Type: application/sdp.
>>>>>>> Content-Length: 259.
>>>>>>> .
>>>>>>> v=3D0.
>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>> s=3DPhone-Call.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> t=3D0 0.
>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>> a=3Dptime:20.
>>>>>>> a=3Dsendrecv.
>>>>>>>
>>>>>>> #
>>>>>>> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 ->     =20
>>>>>>> 178.21.248.7:5060
>>>>>>> SIP/2.0 180 Ringing.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48=
.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.=20
>>>>>>>
>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>> Allow:
>>>>>>>
>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCR=
IBE,UPDATE.=20
>>>>>>>
>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>> Content-Type: application/sdp.
>>>>>>> Content-Length: 259.
>>>>>>> .
>>>>>>> v=3D0.
>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>> s=3DPhone-Call.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> t=3D0 0.
>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>> a=3Dptime:20.
>>>>>>> a=3Dsendrecv.
>>>>>>>
>>>>>>> #
>>>>>>> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 ->     =20
>>>>>>> 178.21.248.20:5060
>>>>>>> SIP/2.0 180 Ringing.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48=
.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.=20
>>>>>>>
>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>> Allow:
>>>>>>>
>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCR=
IBE,UPDATE.=20
>>>>>>>
>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>> Content-Type: application/sdp.
>>>>>>> Content-Length: 259.
>>>>>>> .
>>>>>>> v=3D0.
>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>> s=3DPhone-Call.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> t=3D0 0.
>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>> a=3Dptime:20.
>>>>>>> a=3Dsendrecv.
>>>>>>>
>>>>>>> ##############################
>>>>>>> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 ->     =20
>>>>>>> 178.21.248.7:5060
>>>>>>> SIP/2.0 200 OK.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48=
.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.=20
>>>>>>>
>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>> Allow:
>>>>>>>
>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCR=
IBE,UPDATE.=20
>>>>>>>
>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>> Content-Type: application/sdp.
>>>>>>> Content-Length: 259.
>>>>>>> .
>>>>>>> v=3D0.
>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>> s=3DPhone-Call.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> t=3D0 0.
>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>> a=3Dptime:20.
>>>>>>> a=3Dsendrecv.
>>>>>>>
>>>>>>> #
>>>>>>> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 ->     =20
>>>>>>> 178.21.248.20:5060
>>>>>>> SIP/2.0 200 OK.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34e=
6c782cc21592.=20
>>>>>>>
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 INVITE.
>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>
>>>>>>>
>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df48=
.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.=20
>>>>>>>
>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>> Allow:
>>>>>>>
>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSCR=
IBE,UPDATE.=20
>>>>>>>
>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>> Content-Type: application/sdp.
>>>>>>> Content-Length: 259.
>>>>>>> .
>>>>>>> v=3D0.
>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>> s=3DPhone-Call.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> t=3D0 0.
>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>> a=3Dptime:20.
>>>>>>> a=3Dsendrecv.
>>>>>>>
>>>>>>> #####<<<<<<<<<<<<<<<<<<<<<<       This is the problem
>>>>>>> packet>>>>>>>>>>>>>>>>>>>>>
>>>>>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->     =20
>>>>>>> 178.21.248.7:5060
>>>>>>> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
>>>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>>>>>> Via: SIP/2.0/UDP
>>>>>>>
>>>>>>>
>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8=
216eb2f7233f.=20
>>>>>>>
>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>> CSeq: 2 ACK.
>>>>>>> Max-Forwards: 69.
>>>>>>>
>>>>>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5=
fd1db02>.=20
>>>>>>>
>>>>>>> User-Agent: Aastra Intelligate.
>>>>>>> Content-Length: 0.
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>>>
>>>>>> --=20
>>>>>> Daniel-Constantin Mierla
>>>>>> http://www.asipto.com
>>>>>>
>>>>>>
>>>>>> _______________________________________________
>>>>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users=20
>>>>>> mailing list
>>>>>> sr-users(a)lists.sip-router.org
>>>>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>>>>>
>>>>>
>>>>> --=20
>>>>> Morten Isaksen
>>>>>
>>>>
>>> --=20
>>> Daniel-Constantin Mierla
>>> http://www.asipto.com
>>>
>>>
>>> _______________________________________________
>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>>> sr-users(a)lists.sip-router.org
>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>>
>>
>>
>

--=20
Daniel-Constantin Mierla
http://www.asipto.com



--===============1201106611==--


From misak@misak.dk Mon Nov 15 21:28:43 2010
From: Morten Isaksen <misak@misak.dk>
To: sr-users@lists.kamailio.org
Subject: Re: [SR-Users] Problem with Kamailio not routing ACK to a 200 OK
Date: Mon, 15 Nov 2010 21:28:36 +0100
Message-ID: <AANLkTikzTsUG39nHtd2NCop2DCyR_2A99+McZRQux3yR@mail.gmail.com>
In-Reply-To: <4CE15018.7060808@gmail.com>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1336553815=="

--===============1336553815==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

Hi Daniel,

Thank you very much for the help.

I will report the bug to Aastra.

/Morten

On Mon, Nov 15, 2010 at 4:22 PM, Daniel-Constantin Mierla
<miconda(a)gmail.com> wrote:
> Hello,
>
> I got the pcap file and had the time too check it. There seems to be an
> extra LF at the end of ACK:
>
> 0230 =C2=A073 65 72 2d 41 67 65 6e =C2=A074 3a 20 41 61 73 74 72 =C2=A0 ser=
-Agen t: Aastr
> 0240 =C2=A061 20 49 6e 74 65 6c 6c =C2=A069 67 61 74 65 0d 0a 43 =C2=A0 a I=
ntell igate..C
> 0250 =C2=A06f 6e 74 65 6e 74 2d 4c =C2=A065 6e 67 74 68 3a 20 30 =C2=A0 ont=
ent-L ength: 0
> 0260 =C2=A00d 0a 0d 0a 0a =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
=C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =
.....
>
> Once the last header is finished and ended with CRLF, there must be another
> CRLF and that's it if content length is 0.
>
> According to wireshark and the capture you sent, there is an extra 0x0a
> (LF), so instead of ending in CRLFCRLF, the ACK ends in CRLFCRLFLF
>
> You can remove the content-length check in sanity function, but I recomend
> you report to vendor to get the issue fixed there.
>
> Cheers,
> Daniel
>
>
> On 11/11/10 11:28 PM, Daniel-Constantin Mierla wrote:
>>
>> Hello,
>>
>> On 11/11/10 11:02 PM, Morten Isaksen wrote:
>>>
>>> Hi Daniel,
>>>
>>> The Via line is OK, it was the email formating.
>>>
>>> I am using Kamailio 3.0.3 and the sanity docs says:
>>>
>>> This function makes a row of sanity checks on the given request. The
>>> function returns false (-1) if one of the checks failed. If one of the
>>> checks fails the module sends a precise error reply via sl_send_reply.
>>> Thus there is no need to reply with a generic error message.
>>
>> it happens sometime that some module parameters control the behavior of
>> exported functions and it is not mentioned in description. This one was
>> discovered pretty recently and the description of sanity_check() don't ref=
er
>> to autodrop parameter. I will try to update asap.
>>
>>> I have solved the problem by removing the sanity_check.
>>>
>>> I am just a bit curious why it failed.
>>
>> That should be found to see where is the failure. As a second guess based
>> on checks, it may be that the ACK has some whitespace in the body. Do you
>> have pcap version of this ACK trace?
>>
>> Daniel
>>
>>> But thank you very much for your help.
>>>
>>> /Morten
>>>
>>> On Thu, Nov 11, 2010 at 8:20 PM, Daniel-Constantin Mierla
>>> <miconda(a)gmail.com> =C2=A0wrote:
>>>>
>>>> Hello,
>>>>
>>>> looking now again at the trace you sent first time, the ACK is:
>>>>
>>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 -> =C2=A0 =C2=A0178.21.2=
48.7:5060
>>>> ACKsip:1105(a)178.21.248.56:5060 =C2=A0SIP/2.0.
>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>>> Via: SIP/2.0/UDP
>>>>
>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b8216=
eb2f7233f.
>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>> Call-ID:AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>> CSeq: 2 ACK.
>>>> Max-Forwards: 69.
>>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.5fd1=
db02>.
>>>> User-Agent: Aastra Intelligate.
>>>> Content-Length: 0.
>>>>
>>>> I thought that it may be the email body formatting so that the second
>>>> Via
>>>> header body gets on next line after SIP/2.0/UDP. Can you check your
>>>> trace,
>>>> is it on next line (i.e., there is a new line)? If the Via is on two
>>>> lines
>>>> like it is presented, then it is invalid. A header body can continue on
>>>> a
>>>> new line, but it as to start with whitespace.
>>>>
>>>> Regarding sanity, the module drops silently broken messages if you don't
>>>> set
>>>> autodrop to 0:
>>>> http://kamailio.org/docs/modules/stable/modules/sanity.html#autodrop
>>>>
>>>> Note that you need latest version of branch 3.1/master for it.
>>>>
>>>> Cheers,
>>>> Daniel
>>>>
>>>> On 11/11/10 1:50 PM, Morten Isaksen wrote:
>>>>>
>>>>> Hi,
>>>>>
>>>>> I narrowed it down to the sanity_check.
>>>>>
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0if(!sanity_check("1511", "7"))
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0{
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0xlog("L_WARN", "=
sanity check - M=3D$rm RURI=3D$ru F=3D$fu
>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0exit;
>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0}
>>>>>
>>>>> The sanity_check fails but does not send a reply back or log the above
>>>>> line. I have commented it out and now the ACK is forwarded.
>>>>>
>>>>> /Morten
>>>>>
>>>>> On Mon, Nov 8, 2010 at 3:00 PM, Morten Isaksen<misak(a)misak.dk>
>>>>> =C2=A0wrote:
>>>>>>
>>>>>> Hi,
>>>>>>
>>>>>> On Fri, Oct 29, 2010 at 10:59 AM, Daniel-Constantin Mierla
>>>>>> <miconda(a)gmail.com> =C2=A0 =C2=A0wrote:
>>>>>>>
>>>>>>> Hello,
>>>>>>>
>>>>>>> On 10/28/10 1:37 PM, Morten Isaksen wrote:
>>>>>>>>
>>>>>>>> Hi,
>>>>>>>>
>>>>>>>> I have a strange problem with Kamailio 3.0.2. When one of our end
>>>>>>>> users makes a call Kamailio does not route the ACK (in response to
>>>>>>>> the
>>>>>>>> 200 OK). For all other end users it works fine.
>>>>>>>>
>>>>>>>> For me it looks the the has_totag() checks for some reason fails and
>>>>>>>> then t_check_trans() thinks it is a ACK to a local transactions and
>>>>>>>> then terminates the script. Otherwise there should be more lines in
>>>>>>>> the log file.
>>>>>>>
>>>>>>> if you add an xlog() after the if with has_totag(), do you get the
>>>>>>> message
>>>>>>> in the logs?
>>>>>>
>>>>>> Sorry for the delay, but a had to wait for the customer to make a test
>>>>>> call.
>>>>>>
>>>>>> I placed a xlog("L_WARN", "has_totag after - M=3D$rm RURI=3D$ru F=3D$fu
>>>>>> T=3D$tu IP=3D$si ID=3D$ci\n"); just after the if (has_totag()) { .. } =
and it
>>>>>> does not show in the log.
>>>>>>
>>>>>> It looks very strange to me. Do you have any ideas what is wrong.
>>>>>>
>>>>>> /Morten
>>>>>>
>>>>>>> Cheers,
>>>>>>> Daniel
>>>>>>>
>>>>>>>> The conf is pretty standard.
>>>>>>>>
>>>>>>>> route{
>>>>>>>>
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "New request - M=3D$rm RU=
RI=3D$ru F=3D$fu T=3D$tu
>>>>>>>> IP=3D$si ID=3D$ci\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN", "ua=3D$ua");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (!mf_process_maxfwd_header("10")) {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 sl_send_repl=
y("483","Too Many Hops");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>>>>
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if(!sanity_check("1511", "7"))
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("Malfor=
med SIP message from $si:$sp\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>>>>
>>>>>>>>
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (has_totag()) {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN=
", "has_totag start - M=3D$rm RURI=3D$ru
>>>>>>>> F=3D$fu
>>>>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # sequential=
 request withing a dialog should
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # take the p=
ath determined by record-routing
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (loose_ro=
ute()) {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 xlog("L_WARN", "loose_route - M=3D$rm RURI=3D$ru
>>>>>>>> F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 route(RELAY);
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 if (is_method("SUBSCRIBE")&& =C2=A0 =C2=A0 =C2=A0uri =3D=3D
>>>>>>>> myself)
>>>>>>>> {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # in-dialog subscribe requests
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 #route(PRESENCE);
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 }
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 if ( is_method("ACK") ) {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if ( t_check_trans() ) {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlo=
g("L_WARN", "ACK
>>>>>>>> t_check_trans - M=3D$rm RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci=
\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # n=
on loose-route, but
>>>>>>>> stateful ACK; must be an ACK after a 487 or e.g. 404 from upstream
>>>>>>>> server
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_r=
elay();
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exi=
t;
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 } else {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlo=
g("Ignoring ACK - M=3D$rm
>>>>>>>> RURI=3D$ru F=3D$fu T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 # A=
CK without matching
>>>>>>>> transaction ... ignore and discard.\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exi=
t;
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 }
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 sl_send_reply("404","Not here");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 xlog("L_WARN=
", "has_totag end - M=3D$rm RURI=3D$ru F=3D$fu
>>>>>>>> T=3D$tu IP=3D$si ID=3D$ci\n");
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>>>>
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 #initial requests
>>>>>>>>
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 # CANCEL processing
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (is_method("CANCEL"))
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 {
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 if (t_check_=
trans())
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=
=A0 =C2=A0 =C2=A0 t_relay();
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 =C2=A0 exit;
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 }
>>>>>>>>
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 setflag(4);
>>>>>>>> =C2=A0 =C2=A0 =C2=A0 =C2=A0 t_check_trans();
>>>>>>>>
>>>>>>>> ...
>>>>>>>>
>>>>>>>> The log files show:
>>>>>>>>
>>>>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>>>>>> <script>: New request - M=3DACK RURI=3Dsip:1105(a)178.21.248.56:5060
>>>>>>>> F=3Dsip:87776688(a)sip.uni-tel.dk T=3Dsip:869
>>>>>>>> 87106(a)sip.uni-tel.dk IP=3D178.21.248.20
>>>>>>>> ID=3DAI231CA9BD0A4A1C53(a)10.0.0.150
>>>>>>>> Oct 28 10:51:13 sip-core-1 /usr/local/sbin/kamailio[10503]: WARNING:
>>>>>>>> <script>: ua=3DAastra Intelligate
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> The trace
>>>>>>>>
>>>>>>>> U 2010/10/28 10:51:02.616337 178.21.248.7:5060 ->
>>>>>>>> =C2=A0178.21.248.56:5060
>>>>>>>> INVITE sip:86987106(a)178.21.248.56 SIP/2.0.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df4=
8.5fd1db02>.
>>>>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Max-Forwards: 68.
>>>>>>>> Contact:<sip:87776688(a)87.104.233.108:5060;line=3DAI7EFC34995E724DD=
7>.
>>>>>>>> Accept: application/sdp.
>>>>>>>> Allow: ACK,BYE,CANCEL,INVITE,NOTIFY,OPTIONS,REFER.
>>>>>>>> P-Preferred-Identity:<sip:87776688(a)sip.uni-tel.dk>.
>>>>>>>> Privacy: none.
>>>>>>>> User-Agent: Aastra Intelligate.
>>>>>>>> Content-Type: application/sdp.
>>>>>>>> Content-Length: 280.
>>>>>>>> X-trunktype: IC.
>>>>>>>> .
>>>>>>>> v=3D0.
>>>>>>>> o=3Dintelligate 1194032777 1194032777 IN IP4 87.104.233.106.
>>>>>>>> s=3Dcall.
>>>>>>>> c=3DIN IP4 178.21.248.22.
>>>>>>>> t=3D0 0.
>>>>>>>> m=3Daudio 60984 RTP/AVP 8 0 18 101.
>>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>>> a=3Drtpmap:0 PCMU/8000.
>>>>>>>> a=3Drtpmap:18 G729/8000.
>>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>>> a=3Dsendrecv.
>>>>>>>> a=3Dptime:20.
>>>>>>>>
>>>>>>>> #
>>>>>>>> U 2010/10/28 10:51:02.636854 178.21.248.56:5060 ->
>>>>>>>> =C2=A0178.21.248.7:5060
>>>>>>>> SIP/2.0 100 Trying.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>>> Allow:
>>>>>>>>
>>>>>>>>
>>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
>>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>>> Content-Length: 0.
>>>>>>>> .
>>>>>>>>
>>>>>>>> #####
>>>>>>>> U 2010/10/28 10:51:04.134445 178.21.248.56:5060 ->
>>>>>>>> =C2=A0178.21.248.7:5060
>>>>>>>> SIP/2.0 183 Session Progress.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df4=
8.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>>> Allow:
>>>>>>>>
>>>>>>>>
>>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
>>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>>> Content-Type: application/sdp.
>>>>>>>> Content-Length: 259.
>>>>>>>> .
>>>>>>>> v=3D0.
>>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>>> s=3DPhone-Call.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> t=3D0 0.
>>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>>> a=3Dptime:20.
>>>>>>>> a=3Dsendrecv.
>>>>>>>>
>>>>>>>> #
>>>>>>>> U 2010/10/28 10:51:04.134748 178.21.248.7:5060 ->
>>>>>>>> =C2=A0178.21.248.20:5060
>>>>>>>> SIP/2.0 183 Session Progress.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df4=
8.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>>> Allow:
>>>>>>>>
>>>>>>>>
>>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
>>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>>> Content-Type: application/sdp.
>>>>>>>> Content-Length: 259.
>>>>>>>> .
>>>>>>>> v=3D0.
>>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>>> s=3DPhone-Call.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> t=3D0 0.
>>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>>> a=3Dptime:20.
>>>>>>>> a=3Dsendrecv.
>>>>>>>>
>>>>>>>> #
>>>>>>>> U 2010/10/28 10:51:04.136586 178.21.248.56:5060 ->
>>>>>>>> =C2=A0178.21.248.7:5060
>>>>>>>> SIP/2.0 180 Ringing.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df4=
8.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>>> Allow:
>>>>>>>>
>>>>>>>>
>>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
>>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>>> Content-Type: application/sdp.
>>>>>>>> Content-Length: 259.
>>>>>>>> .
>>>>>>>> v=3D0.
>>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>>> s=3DPhone-Call.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> t=3D0 0.
>>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>>> a=3Dptime:20.
>>>>>>>> a=3Dsendrecv.
>>>>>>>>
>>>>>>>> #
>>>>>>>> U 2010/10/28 10:51:04.136837 178.21.248.7:5060 ->
>>>>>>>> =C2=A0178.21.248.20:5060
>>>>>>>> SIP/2.0 180 Ringing.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df4=
8.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>>> Allow:
>>>>>>>>
>>>>>>>>
>>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
>>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>>> Content-Type: application/sdp.
>>>>>>>> Content-Length: 259.
>>>>>>>> .
>>>>>>>> v=3D0.
>>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>>> s=3DPhone-Call.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> t=3D0 0.
>>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>>> a=3Dptime:20.
>>>>>>>> a=3Dsendrecv.
>>>>>>>>
>>>>>>>> ##############################
>>>>>>>> U 2010/10/28 10:51:12.881179 178.21.248.56:5060 ->
>>>>>>>> =C2=A0178.21.248.7:5060
>>>>>>>> SIP/2.0 200 OK.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.7;branch=3Dz9hG4bK690c.9cfea506.0.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df4=
8.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>>> Allow:
>>>>>>>>
>>>>>>>>
>>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
>>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>>> Content-Type: application/sdp.
>>>>>>>> Content-Length: 259.
>>>>>>>> .
>>>>>>>> v=3D0.
>>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>>> s=3DPhone-Call.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> t=3D0 0.
>>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>>> a=3Dptime:20.
>>>>>>>> a=3Dsendrecv.
>>>>>>>>
>>>>>>>> #
>>>>>>>> U 2010/10/28 10:51:12.882388 178.21.248.7:5060 ->
>>>>>>>> =C2=A0178.21.248.20:5060
>>>>>>>> SIP/2.0 200 OK.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.0.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK3c70fae55c8b362ff34=
e6c782cc21592.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 INVITE.
>>>>>>>> Contact:<sip:1105(a)178.21.248.56:5060>.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> Record-Route:<sip:178.21.248.7;lr;ftag=3DAI8DA85D59B9B6634F;did=3Df4=
8.5fd1db02>,<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Supported: em,timer,replaces,path,early-session,resource-priority.
>>>>>>>> Allow:
>>>>>>>>
>>>>>>>>
>>>>>>>> REGISTER,OPTIONS,INVITE,ACK,CANCEL,BYE,NOTIFY,PRACK,REFER,INFO,SUBSC=
RIBE,UPDATE.
>>>>>>>> Server: Audiocodes-Sip-Gateway-Mediant 2000/v.5.60A.035.002.
>>>>>>>> Content-Type: application/sdp.
>>>>>>>> Content-Length: 259.
>>>>>>>> .
>>>>>>>> v=3D0.
>>>>>>>> o=3DAudiocodesGW 2073965634 2073965290 IN IP4 178.21.248.56.
>>>>>>>> s=3DPhone-Call.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> t=3D0 0.
>>>>>>>> m=3Daudio 6050 RTP/AVP 8 101.
>>>>>>>> c=3DIN IP4 178.21.248.56.
>>>>>>>> a=3Drtpmap:8 PCMA/8000.
>>>>>>>> a=3Drtpmap:101 telephone-event/8000.
>>>>>>>> a=3Dfmtp:101 0-15.
>>>>>>>> a=3Dptime:20.
>>>>>>>> a=3Dsendrecv.
>>>>>>>>
>>>>>>>> #####<<<<<<<<<<<<<<<<<<<<<< =C2=A0 =C2=A0 =C2=A0 This is the problem
>>>>>>>> packet>>>>>>>>>>>>>>>>>>>>>
>>>>>>>> U 2010/10/28 10:51:13.267863 178.21.248.20:5060 ->
>>>>>>>> =C2=A0178.21.248.7:5060
>>>>>>>> ACK sip:1105(a)178.21.248.56:5060 SIP/2.0.
>>>>>>>> Record-Route:<sip:178.21.248.20;lr;ftag=3DAI8DA85D59B9B6634F>.
>>>>>>>> Via: SIP/2.0/UDP 178.21.248.20;branch=3Dz9hG4bK690c.97354e4.2.
>>>>>>>> Via: SIP/2.0/UDP
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>> 87.104.233.108:5060;rport=3D5060;branch=3Dz9hG4bK07103fe69c8af048b9b=
8216eb2f7233f.
>>>>>>>> To:<sip:86987106(a)sip.uni-tel.dk>;tag=3D1c2073920452.
>>>>>>>> From:<sip:87776688(a)sip.uni-tel.dk>;tag=3DAI8DA85D59B9B6634F.
>>>>>>>> Call-ID: AI231CA9BD0A4A1C53(a)10.0.0.150.
>>>>>>>> CSeq: 2 ACK.
>>>>>>>> Max-Forwards: 69.
>>>>>>>>
>>>>>>>>
>>>>>>>> Route:<sip:178.21.248.7;lr=3Don;ftag=3DAI8DA85D59B9B6634F;did=3Df48.=
5fd1db02>.
>>>>>>>> User-Agent: Aastra Intelligate.
>>>>>>>> Content-Length: 0.
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>>>
>>>>>>> --
>>>>>>> Daniel-Constantin Mierla
>>>>>>> http://www.asipto.com
>>>>>>>
>>>>>>>
>>>>>>> _______________________________________________
>>>>>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing
>>>>>>> list
>>>>>>> sr-users(a)lists.sip-router.org
>>>>>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>>>>>>
>>>>>>
>>>>>> --
>>>>>> Morten Isaksen
>>>>>>
>>>>>
>>>> --
>>>> Daniel-Constantin Mierla
>>>> http://www.asipto.com
>>>>
>>>>
>>>> _______________________________________________
>>>> SIP Express Router (SER) and Kamailio (OpenSER) - sr-users mailing list
>>>> sr-users(a)lists.sip-router.org
>>>> http://lists.sip-router.org/cgi-bin/mailman/listinfo/sr-users
>>>>
>>>
>>>
>>
>
> --
> Daniel-Constantin Mierla
> http://www.asipto.com
>
>



--=20
Morten Isaksen


--===============1336553815==--