500 Server error occurred (1/SL)

Discussion:

Ovidiu Sas

2007-02-13 03:23:37 UTC

Hi,

I got this bizarre 500 error (openser 1.2.0-pre4-tls (arm/linux)).

192.168.2.102 - CISCO IP PHONE
192.168.2.22 - openser
192.168.2.20 - asterisk

Cisco --> openser --> asterisk

Here's the the log:
ERROR:tm:t_forward_nonack: no branch for forwarding
ERROR:tm:w_t_relay: t_forward_nonack failed
ERR: t_relay() in route[1]

and here's the ngrep:
#
U 2007/02/12 21:03:59.644707 192.168.2.102:50611 -> 192.168.2.22:5060
INVITE sip:4169771414-***@public.gmane.org;user=phone SIP/2.0.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6" <sip:line-6-***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
Max-Forwards: 70.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Contact: <sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org:5060>.
Proxy-Authorization: Digest
username="line-6",realm="192.168.2.22",uri="sip:4169771414-***@public.gmane.org;user=phone",response="16f0ea81a76e28996eefcf4d9b5cfb38",nonce="45d0d76bed759d9c74a1f2c55e052931bda8c01a",algorithm=md5.
Expires: 180.
Remote-Party-ID: "Line 6"
<sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org>;party=calling;id-type=subscriber;privacy=off;screen=yes.
Content-Length: 256.
Content-Type: application/sdp.
Content-Disposition: session;handling=optional.
.
v=0.
o=Cisco-SIPUA 9502 0 IN IP4 192.168.2.102.
s=SIP Call.
t=0 0.
m=audio 29660 RTP/AVP 0 8 18 101.
c=IN IP4 192.168.2.102.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=sendrecv.

U 2007/02/12 21:03:59.653481 192.168.2.22:5060 -> 192.168.2.20:5060
INVITE sip:4169771414-Q0ErXNX1RubgbN+***@public.gmane.org:5060;transport=udp SIP/2.0.
Record-Route: <sip:192.168.2.22;lr;ftag=00036be7b12459bc6a35fdb5-427c1545;vsf=AAAAAA0HAQtUWy9ESnIfAwEWHhweHAM->.
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
<sip:anonymous-savSHZN5Fh8qMp+***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
Max-Forwards: 69.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Contact: <sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org:5060>.
Expires: 180.
Remote-Party-ID: "Line 6"
<sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org>;party=calling;id-type=subscriber;privacy=off;screen=yes.
Content-Length: 256.
Content-Type: application/sdp.
Content-Disposition: session;handling=optional.
.
v=0.
o=Cisco-SIPUA 9502 0 IN IP4 192.168.2.102.
s=SIP Call.
t=0 0.
m=audio 29660 RTP/AVP 0 8 18 101.
c=IN IP4 192.168.2.102.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=sendrecv.

U 2007/02/12 21:03:59.665261 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 100 Trying.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
<sip:anonymous-savSHZN5Fh8qMp+***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
CSeq: 102 INVITE.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Contact: <sip:4169771414-Q0ErXNX1RubgbN+***@public.gmane.org>.
Content-Length: 0.
.

U 2007/02/12 21:04:00.144269 192.168.2.102:50611 -> 192.168.2.22:5060
INVITE sip:4169771414-***@public.gmane.org;user=phone SIP/2.0.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6" <sip:line-6-***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
Max-Forwards: 70.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Contact: <sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org:5060>.
Proxy-Authorization: Digest
username="line-6",realm="192.168.2.22",uri="sip:4169771414-***@public.gmane.org;user=phone",response="16f0ea81a76e28996eefcf4d9b5cfb38",nonce="45d0d76bed759d9c74a1f2c55e052931bda8c01a",algorithm=md5.
Expires: 180.
Remote-Party-ID: "Line 6"
<sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org>;party=calling;id-type=subscriber;privacy=off;screen=yes.
Content-Length: 256.
Content-Type: application/sdp.
Content-Disposition: session;handling=optional.
.
v=0.
o=Cisco-SIPUA 9502 0 IN IP4 192.168.2.102.
s=SIP Call.
t=0 0.
m=audio 29660 RTP/AVP 0 8 18 101.
c=IN IP4 192.168.2.102.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=sendrecv.

U 2007/02/12 21:04:00.153226 192.168.2.22:5060 -> 192.168.2.102:5060
SIP/2.0 500 Server error occurred (1/SL).
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6" <sip:line-6-***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>;tag=329cfeaa6ded039da25ff8cbb8668bd2.4856.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
CSeq: 102 INVITE.
Server: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.

U 2007/02/12 21:04:00.262754 192.168.2.102:51526 -> 192.168.2.22:5060
ACK sip:4169771414-***@public.gmane.org;user=phone SIP/2.0.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6" <sip:line-6-***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>;tag=329cfeaa6ded039da25ff8cbb8668bd2.4856.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
Date: Tue, 13 Feb 2007 02:03:39 GMT.
CSeq: 102 ACK.
Content-Length: 0.
.

U 2007/02/12 21:04:03.731337 192.168.2.22:5060 -> 192.168.2.20:5060
CANCEL sip:4169771414-Q0ErXNX1RubgbN+***@public.gmane.org:5060;transport=udp SIP/2.0.
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
From: "Anonymous"
<sip:anonymous-savSHZN5Fh8qMp+***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
To: <sip:4169771414-***@public.gmane.org;user=phone>.
CSeq: 102 CANCEL.
User-Agent: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.

U 2007/02/12 21:04:03.734855 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 487 Request Terminated.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
<sip:anonymous-savSHZN5Fh8qMp+***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>;tag=as02cb988d.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
CSeq: 102 INVITE.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Content-Length: 0.
.

U 2007/02/12 21:04:03.735902 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
From: "Anonymous"
<sip:anonymous-savSHZN5Fh8qMp+***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
To: <sip:4169771414-***@public.gmane.org;user=phone>;tag=as02cb988d.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
CSeq: 102 CANCEL.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Contact: <sip:4169771414-Q0ErXNX1RubgbN+***@public.gmane.org>.
Content-Length: 0.
.

U 2007/02/12 21:04:03.736114 192.168.2.22:5060 -> 192.168.2.20:5060
ACK sip:4169771414-Q0ErXNX1RubgbN+***@public.gmane.org:5060;transport=udp SIP/2.0.
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
From: "Anonymous"
<sip:anonymous-savSHZN5Fh8qMp+***@public.gmane.org>;tag=00036be7b12459bc6a35fdb5-427c1545.
Call-ID: 00036be7-b1240073-27eb575a-3c266a6b-Q0ErXNX1RuY/***@public.gmane.org
To: <sip:4169771414-***@public.gmane.org;user=phone>;tag=as02cb988d.
CSeq: 102 ACK.
User-Agent: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.

Bogdan-Andrei Iancu

2007-02-13 18:09:15 UTC

Permalink

Hi Ovidiu,

second INVITE looks to be a retransmission. Are you using t_newtran() +
t_relay() ?? what is the script sequence for relaying?

regards,
bogdan

Post by Ovidiu Sas
Hi,
I got this bizarre 500 error (openser 1.2.0-pre4-tls (arm/linux)).
192.168.2.102 - CISCO IP PHONE
192.168.2.22 - openser
192.168.2.20 - asterisk
Cisco --> openser --> asterisk
ERROR:tm:t_forward_nonack: no branch for forwarding
ERROR:tm:w_t_relay: t_forward_nonack failed
ERR: t_relay() in route[1]
#
U 2007/02/12 21:03:59.644707 192.168.2.102:50611 -> 192.168.2.22:5060
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6"
Max-Forwards: 70.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Proxy-Authorization: Digest
Expires: 180.
Remote-Party-ID: "Line 6"
Content-Length: 256.
Content-Type: application/sdp.
Content-Disposition: session;handling=optional.
.
v=0.
o=Cisco-SIPUA 9502 0 IN IP4 192.168.2.102.
s=SIP Call.
t=0 0.
m=audio 29660 RTP/AVP 0 8 18 101.
c=IN IP4 192.168.2.102.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=sendrecv.
U 2007/02/12 21:03:59.653481 192.168.2.22:5060 -> 192.168.2.20:5060
<sip:192.168.2.22;lr;ftag=00036be7b12459bc6a35fdb5-427c1545;vsf=AAAAAA0HAQtUWy9ESnIfAwEWHhweHAM->.
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
Max-Forwards: 69.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Expires: 180.
Remote-Party-ID: "Line 6"
Content-Length: 256.
Content-Type: application/sdp.
Content-Disposition: session;handling=optional.
.
v=0.
o=Cisco-SIPUA 9502 0 IN IP4 192.168.2.102.
s=SIP Call.
t=0 0.
m=audio 29660 RTP/AVP 0 8 18 101.
c=IN IP4 192.168.2.102.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=sendrecv.
U 2007/02/12 21:03:59.665261 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 100 Trying.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
CSeq: 102 INVITE.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Content-Length: 0.
.
U 2007/02/12 21:04:00.144269 192.168.2.102:50611 -> 192.168.2.22:5060
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6"
Max-Forwards: 70.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Proxy-Authorization: Digest
Expires: 180.
Remote-Party-ID: "Line 6"
Content-Length: 256.
Content-Type: application/sdp.
Content-Disposition: session;handling=optional.
.
v=0.
o=Cisco-SIPUA 9502 0 IN IP4 192.168.2.102.
s=SIP Call.
t=0 0.
m=audio 29660 RTP/AVP 0 8 18 101.
c=IN IP4 192.168.2.102.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=sendrecv.
U 2007/02/12 21:04:00.153226 192.168.2.22:5060 -> 192.168.2.102:5060
SIP/2.0 500 Server error occurred (1/SL).
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6"
CSeq: 102 INVITE.
Server: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.
U 2007/02/12 21:04:00.262754 192.168.2.102:51526 -> 192.168.2.22:5060
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6"
Date: Tue, 13 Feb 2007 02:03:39 GMT.
CSeq: 102 ACK.
Content-Length: 0.
.
U 2007/02/12 21:04:03.731337 192.168.2.22:5060 -> 192.168.2.20:5060
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
From: "Anonymous"
CSeq: 102 CANCEL.
User-Agent: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.
U 2007/02/12 21:04:03.734855 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 487 Request Terminated.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
CSeq: 102 INVITE.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Content-Length: 0.
.
U 2007/02/12 21:04:03.735902 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
From: "Anonymous"
CSeq: 102 CANCEL.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Content-Length: 0.
.
U 2007/02/12 21:04:03.736114 192.168.2.22:5060 -> 192.168.2.20:5060
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
From: "Anonymous"
CSeq: 102 ACK.
User-Agent: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.
_______________________________________________
Devel mailing list
http://openser.org/cgi-bin/mailman/listinfo/devel

Ovidiu Sas

2007-02-13 18:21:28 UTC

Permalink

Hi Bogdan,

Yes, the second INVITE is a retransmission.
The script is pretty simple: lcr followed by t_relay("0x01").
I just don't send back a 100 Trying. Could this cause issues?

Regards,
Ovidiu Sas

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
second INVITE looks to be a retransmission. Are you using t_newtran() +
t_relay() ?? what is the script sequence for relaying?
regards,
bogdan

Ovidiu Sas

2007-02-14 14:41:29 UTC

Permalink

Hi Bogdan,

The problem is triggered when from mangling is involved and t_relay is
used in manual mode and 100 Trying is not sent.
An INVITE comes in. It's From headers is mangled and then is sent out
(using usrloc lookup). The INVITE is relayed using t_relay("0x01")
and no "100 Trying" is sent out.
On the first INVITE retransmission, the bug will occur.

Regards,
Ovidiu Sas

Post by Ovidiu Sas
Hi Bogdan,
Yes, the second INVITE is a retransmission.
The script is pretty simple: lcr followed by t_relay("0x01").
I just don't send back a 100 Trying. Could this cause issues?
Regards,
Ovidiu Sas

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
second INVITE looks to be a retransmission. Are you using t_newtran() +
t_relay() ?? what is the script sequence for relaying?
regards,
bogdan

Bogdan-Andrei Iancu

2007-02-14 17:15:07 UTC

Permalink

Hi Ovidiu,

I found the bug - it is a very spuky one with no obvious fix - by having
the t_relay() to work on an already created transaction, the
retransmission detection was bit (more) screwed up.....:(

regards,
bogdan

Post by Ovidiu Sas
Hi Bogdan,
The problem is triggered when from mangling is involved and t_relay is
used in manual mode and 100 Trying is not sent.
An INVITE comes in. It's From headers is mangled and then is sent out
(using usrloc lookup). The INVITE is relayed using t_relay("0x01")
and no "100 Trying" is sent out.
On the first INVITE retransmission, the bug will occur.
Regards,
Ovidiu Sas

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
second INVITE looks to be a retransmission. Are you using

t_newtran() +

Post by Bogdan-Andrei Iancu
t_relay() ?? what is the script sequence for relaying?
regards,
bogdan

Ovidiu Sas

2007-02-14 17:57:29 UTC

Permalink

ok. At least we are on the same page =)
I will open a bug so we can keep track of it.

Regards,
Ovidiu Sas

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
I found the bug - it is a very spuky one with no obvious fix - by having
the t_relay() to work on an already created transaction, the
retransmission detection was bit (more) screwed up.....:(
regards,
bogdan

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
second INVITE looks to be a retransmission. Are you using

t_newtran() +

Post by Bogdan-Andrei Iancu
t_relay() ?? what is the script sequence for relaying?
regards,
bogdan

Bogdan-Andrei Iancu

2007-02-16 11:08:04 UTC

Permalink

Hi Ovidiu,

I made a fix on CVS - could you please update and re-test to see if the
problem is really solved? actually your report made me discover 2 bugs
:D.....both related to retransmission handling....

thanks and regards,
bogdan

Post by Ovidiu Sas
ok. At least we are on the same page =)
I will open a bug so we can keep track of it.
Regards,
Ovidiu Sas

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
second INVITE looks to be a retransmission. Are you using

t_newtran() +

Post by Bogdan-Andrei Iancu
t_relay() ?? what is the script sequence for relaying?
regards,
bogdan

Post by Ovidiu Sas
Hi,
I got this bizarre 500 error (openser 1.2.0-pre4-tls

(arm/linux)).

Post by Ovidiu Sas

Post by Bogdan-Andrei Iancu

Post by Ovidiu Sas
192.168.2.102 - CISCO IP PHONE
192.168.2.22 - openser
192.168.2.20 - asterisk
Cisco --> openser --> asterisk
ERROR:tm:t_forward_nonack: no branch for forwarding
ERROR:tm:w_t_relay: t_forward_nonack failed
ERR: t_relay() in route[1]

Ovidiu Sas

2007-02-16 15:38:01 UTC

Permalink

Hi Bogdan,

tested ok :-)

Best regards,
Ovidiu Sas

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
I made a fix on CVS - could you please update and re-test to see if the
problem is really solved? actually your report made me discover 2 bugs
:D.....both related to retransmission handling....
thanks and regards,
bogdan

Post by Ovidiu Sas
ok. At least we are on the same page =)
I will open a bug so we can keep track of it.
Regards,
Ovidiu Sas

Post by Bogdan-Andrei Iancu
Hi Ovidiu,
second INVITE looks to be a retransmission. Are you using

t_newtran() +

Post by Bogdan-Andrei Iancu
t_relay() ?? what is the script sequence for relaying?
regards,
bogdan

Post by Ovidiu Sas
Hi,
I got this bizarre 500 error (openser 1.2.0-pre4-tls

(arm/linux)).

Post by Ovidiu Sas

Post by Bogdan-Andrei Iancu

CARTWRIGHT, CORY C (ATTSNET)

2007-03-16 11:54:07 UTC

Permalink

Are the "." after each line in the capture below caused by ngrep or just
in the email?

-----Original Message-----
From: devel-bounces-***@public.gmane.org [mailto:devel-bounces-***@public.gmane.org] On
Behalf Of Bogdan-Andrei Iancu
Sent: Tuesday, February 13, 2007 1:09 PM
To: Ovidiu Sas
Cc: devel-***@public.gmane.org
Subject: Re: [Devel] 500 Server error occurred (1/SL)

Hi Ovidiu,

second INVITE looks to be a retransmission. Are you using t_newtran() +
t_relay() ?? what is the script sequence for relaying?

regards,
bogdan

username="line-6",realm="192.168.2.22",uri="sip:4169771414-***@public.gmane.org2.22;
user=phone",response="16f0ea81a76e28996eefcf4d9b5cfb38",nonce="45d0d76be
d759d9c74a1f2c55e052931bda8c01a",algorithm=md5.

Post by Ovidiu Sas
Expires: 180.
Remote-Party-ID: "Line 6"

<sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org>;party=calling;id-type=subscriber;privacy=off;
screen=yes.

<sip:192.168.2.22;lr;ftag=00036be7b12459bc6a35fdb5-427c1545;vsf=AAAAAA0H
AQtUWy9ESnIfAwEWHhweHAM->.

Post by Ovidiu Sas
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
Max-Forwards: 69.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Expires: 180.
Remote-Party-ID: "Line 6"

<sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org>;party=calling;id-type=subscriber;privacy=off;
screen=yes.

Post by Ovidiu Sas
Content-Length: 256.
Content-Type: application/sdp.
Content-Disposition: session;handling=optional.
.
v=0.
o=Cisco-SIPUA 9502 0 IN IP4 192.168.2.102.
s=SIP Call.
t=0 0.
m=audio 29660 RTP/AVP 0 8 18 101.
c=IN IP4 192.168.2.102.
a=rtpmap:0 PCMU/8000.
a=rtpmap:8 PCMA/8000.
a=rtpmap:18 G729/8000.
a=rtpmap:101 telephone-event/8000.
a=fmtp:101 0-15.
a=sendrecv.
U 2007/02/12 21:03:59.665261 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 100 Trying.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
CSeq: 102 INVITE.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Content-Length: 0.
.
U 2007/02/12 21:04:00.144269 192.168.2.102:50611 -> 192.168.2.22:5060
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6"
Max-Forwards: 70.
Date: Tue, 13 Feb 2007 02:03:38 GMT.
CSeq: 102 INVITE.
User-Agent: Cisco-CP7960G/7.5.
Proxy-Authorization: Digest

Post by Ovidiu Sas
Expires: 180.
Remote-Party-ID: "Line 6"

<sip:line-6-Q0ErXNX1RuZugTOVEmv/***@public.gmane.org>;party=calling;id-type=subscriber;privacy=off;
screen=yes.

<sip:4169771414-***@public.gmane.org;user=phone>;tag=329cfeaa6ded039da25ff8cbb86
68bd2.4856.

Post by Ovidiu Sas
CSeq: 102 INVITE.
Server: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.
U 2007/02/12 21:04:00.262754 192.168.2.102:51526 -> 192.168.2.22:5060
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Line 6"

<sip:4169771414-***@public.gmane.org;user=phone>;tag=329cfeaa6ded039da25ff8cbb86
68bd2.4856.

Post by Ovidiu Sas
Date: Tue, 13 Feb 2007 02:03:39 GMT.
CSeq: 102 ACK.
Content-Length: 0.
.
U 2007/02/12 21:04:03.731337 192.168.2.22:5060 -> 192.168.2.20:5060
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
From: "Anonymous"
CSeq: 102 CANCEL.
User-Agent: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.
U 2007/02/12 21:04:03.734855 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 487 Request Terminated.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
Via: SIP/2.0/UDP 192.168.2.102:5060;branch=z9hG4bK6fc15dd5.
From: "Anonymous"
CSeq: 102 INVITE.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Content-Length: 0.
.
U 2007/02/12 21:04:03.735902 192.168.2.20:5060 -> 192.168.2.22:5060
SIP/2.0 200 OK.
Via: SIP/2.0/UDP
192.168.2.22;branch=z9hG4bK4829.d237633.0;received=192.168.2.22.
From: "Anonymous"
CSeq: 102 CANCEL.
User-Agent: Asterisk PBX.
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY.
Supported: replaces.
Content-Length: 0.
.
U 2007/02/12 21:04:03.736114 192.168.2.22:5060 -> 192.168.2.20:5060
Via: SIP/2.0/UDP 192.168.2.22;branch=z9hG4bK4829.d237633.0.
From: "Anonymous"
CSeq: 102 ACK.
User-Agent: OpenSer (1.2.0-pre4-tls (arm/linux)).
Content-Length: 0.
.
_______________________________________________
Devel mailing list
http://openser.org/cgi-bin/mailman/listinfo/devel

Klaus Darilion

2007-03-16 12:01:58 UTC

Permalink

ngrep

Post by CARTWRIGHT, CORY C (ATTSNET)
Are the "." after each line in the capture below caused by ngrep or just
in the email?
-----Original Message-----
Behalf Of Bogdan-Andrei Iancu
Sent: Tuesday, February 13, 2007 1:09 PM
To: Ovidiu Sas
Subject: Re: [Devel] 500 Server error occurred (1/SL)
Hi Ovidiu,
second INVITE looks to be a retransmission. Are you using t_newtran() +
t_relay() ?? what is the script sequence for relaying?
regards,
bogdan

user=phone",response="16f0ea81a76e28996eefcf4d9b5cfb38",nonce="45d0d76be
d759d9c74a1f2c55e052931bda8c01a",algorithm=md5.

Post by Ovidiu Sas
Expires: 180.
Remote-Party-ID: "Line 6"

screen=yes.

<sip:192.168.2.22;lr;ftag=00036be7b12459bc6a35fdb5-427c1545;vsf=AAAAAA0H
AQtUWy9ESnIfAwEWHhweHAM->.

screen=yes.

user=phone",response="16f0ea81a76e28996eefcf4d9b5cfb38",nonce="45d0d76be
d759d9c74a1f2c55e052931bda8c01a",algorithm=md5.

Post by Ovidiu Sas
Expires: 180.
Remote-Party-ID: "Line 6"

screen=yes.

68bd2.4856.

_______________________________________________
Devel mailing list
http://openser.org/cgi-bin/mailman/listinfo/devel
_______________________________________________
Devel mailing list
http://openser.org/cgi-bin/mailman/listinfo/devel

--
Klaus Darilion
nic.at

Ovidiu Sas

2007-03-16 12:37:56 UTC

Permalink

yes, ngrep.
Check the ngrep manual:

"-P char
Change the non-printable character from the default ``.'' to the
character specified."

In this case the '.' is '\r' character.

Regards,
Ovidiu Sas

user=phone",response="16f0ea81a76e28996eefcf4d9b5cfb38",nonce="45d0d76be
d759d9c74a1f2c55e052931bda8c01a",algorithm=md5.

Post by Ovidiu Sas
Expires: 180.
Remote-Party-ID: "Line 6"

screen=yes.

<sip:192.168.2.22;lr;ftag=00036be7b12459bc6a35fdb5-427c1545;vsf=AAAAAA0H
AQtUWy9ESnIfAwEWHhweHAM->.

screen=yes.

user=phone",response="16f0ea81a76e28996eefcf4d9b5cfb38",nonce="45d0d76be
d759d9c74a1f2c55e052931bda8c01a",algorithm=md5.

Post by Ovidiu Sas
Expires: 180.
Remote-Party-ID: "Line 6"

screen=yes.

68bd2.4856.

_______________________________________________
Devel mailing list
http://openser.org/cgi-bin/mailman/listinfo/devel