TCP timeout

classic Classic list List threaded Threaded
4 messages Options
Reply | Threaded
Open this post in threaded view
|

TCP timeout

Andrei Bucur
Hi,

I use opensips 1.6.4-notls and I configure it to listen on TCP 5060 and UDP
5060
Everything is working ok on the UDP part but if using TCP 5060 the call
hangs up after about 130 sec

The problem seems like to be tcpconn_timeout:
==================================================================================================
Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]: DBG:core:tcpconn_timeout: timeout for hash=2 - 0x7ff3d90703d0 (2816 > 2811)
Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]: DBG:core:io_watch_del: io_watch_del (0x762c20, 40, -1, 0x10) fd_no=30 called
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]: DBG:core:print_ip: tcpconn_new: new tcp connection to: 192.168.231.55
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]: DBG:core:tcpconn_new: on port 33598, type 2
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]: DBG:core:tcpconn_add: hashes: 255, 3
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]: DBG:core:handle_new_connect: new connection: 0x7ff3d90703d0 40 flags: 0002
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]: DBG:core:send2child: to tcp child 0 0(15882), 0x7ff3d90703d0
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:handle_io: received n=8 con=0x7ff3d90703d0, fd=36
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:io_watch_add: io_watch_add(0x762d80, 36, 2, 0x7ff3d90703d0), fd_no=1
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:tcp_read_req: content-length= 0
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:parse_msg: SIP Request:
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:parse_msg:  method:  <BYE>
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:parse_msg:  uri:     <sip:*43@192.168.230.21>
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:parse_msg:  version: <SIP/2.0>
Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]: DBG:core:parse_headers: flags=2
==================================================================================================
 
Any suggestion ?
Thank you,
Andrei


_______________________________________________
Users mailing list
[hidden email]
http://lists.opensips.org/cgi-bin/mailman/listinfo/users
Reply | Threaded
Open this post in threaded view
|

Re: TCP timeout

Bogdan-Andrei Iancu
Hi Andrei,

which party do hang up the call ? caller? callee ? after the call setup
(200 OK), do you any ACK from caller to callee ? Maybe the ACK is not
properly routed to callee and callee fires a BYE request - maybe a sip
capture from opensips machine will help.

Regards,
Bogdan

Andrei Bucur wrote:

> Hi,
>
> I use opensips 1.6.4-notls and I configure it to listen on TCP 5060
> and UDP
> 5060
> Everything is working ok on the UDP part but if using TCP 5060 the call
> hangs up after about 130 sec
>
> The problem seems like to be tcpconn_timeout:
> ==================================================================================================
> Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:tcpconn_timeout: timeout for hash=2 - 0x7ff3d90703d0 (2816 >
> 2811)
> Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:io_watch_del: io_watch_del (0x762c20, 40, -1, 0x10) fd_no=30
> called
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:print_ip: tcpconn_new: new tcp connection to: 192.168.231.55
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:tcpconn_new: on port 33598, type 2
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:tcpconn_add: hashes: 255, 3
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:handle_new_connect: new connection: 0x7ff3d90703d0 40 flags: 0002
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:send2child: to tcp child 0 0(15882), 0x7ff3d90703d0
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:handle_io: received n=8 con=0x7ff3d90703d0, fd=36
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:io_watch_add: io_watch_add(0x762d80, 36, 2, 0x7ff3d90703d0),
> fd_no=1
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:tcp_read_req: content-length= 0
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg: SIP Request:
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg:  method:  <BYE>
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg:  uri:     <sip:*43@192.168.230.21>
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg:  version: <SIP/2.0>
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_headers: flags=2
> ==================================================================================================
>  
> Any suggestion ?
> Thank you,
> Andrei
>
> ------------------------------------------------------------------------
>
> _______________________________________________
> Users mailing list
> [hidden email]
> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>  


--
Bogdan-Andrei Iancu
OpenSIPS Event - expo, conf, social, bootcamp
2 - 4 February 2011, ITExpo, Miami,  USA
www.voice-system.ro


_______________________________________________
Users mailing list
[hidden email]
http://lists.opensips.org/cgi-bin/mailman/listinfo/users
Reply | Threaded
Open this post in threaded view
|

Re: TCP timeout

Andrei Bucur
In reply to this post by Andrei Bucur
Hi Bogdan,

I have the following topology:

Nokia SIP client ------ router --------- OpenSIPS ---------- Asterisk
192.168.253.235     82.76.196.2 193.0.0.30
193.0.0.21

I attached the captured files with opensips logs and packets on 193.0.0.30
port 5060

I belive ACK is not routed properly

Thank you,
Andrei


-----Original Message-----
From: [hidden email]
[mailto:[hidden email]] On Behalf Of Bogdan-Andrei Iancu
Sent: Friday, January 07, 2011 6:26 PM
To: OpenSIPS users mailling list
Subject: Re: [OpenSIPS-Users] TCP timeout

Hi Andrei,

which party do hang up the call ? caller? callee ? after the call setup
(200 OK), do you any ACK from caller to callee ? Maybe the ACK is not
properly routed to callee and callee fires a BYE request - maybe a sip
capture from opensips machine will help.

Regards,
Bogdan

Andrei Bucur wrote:

> Hi,
>
> I use opensips 1.6.4-notls and I configure it to listen on TCP 5060
> and UDP
> 5060
> Everything is working ok on the UDP part but if using TCP 5060 the call
> hangs up after about 130 sec
>
> The problem seems like to be tcpconn_timeout:
>
============================================================================
======================

> Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:tcpconn_timeout: timeout for hash=2 - 0x7ff3d90703d0 (2816 >
> 2811)
> Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:io_watch_del: io_watch_del (0x762c20, 40, -1, 0x10) fd_no=30
> called
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:print_ip: tcpconn_new: new tcp connection to: 192.168.231.55
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:tcpconn_new: on port 33598, type 2
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:tcpconn_add: hashes: 255, 3
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:handle_new_connect: new connection: 0x7ff3d90703d0 40 flags: 0002
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
> DBG:core:send2child: to tcp child 0 0(15882), 0x7ff3d90703d0
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:handle_io: received n=8 con=0x7ff3d90703d0, fd=36
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:io_watch_add: io_watch_add(0x762d80, 36, 2, 0x7ff3d90703d0),
> fd_no=1
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:tcp_read_req: content-length= 0
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg: SIP Request:
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg:  method:  <BYE>
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg:  uri:     <sip:*43@192.168.230.21>
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_msg:  version: <SIP/2.0>
> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
> DBG:core:parse_headers: flags=2
>
============================================================================
======================

>  
> Any suggestion ?
> Thank you,
> Andrei
>
> ------------------------------------------------------------------------
>
> _______________________________________________
> Users mailing list
> [hidden email]
> http://lists.opensips.org/cgi-bin/mailman/listinfo/users
>  

--
Bogdan-Andrei Iancu
OpenSIPS Event - expo, conf, social, bootcamp
2 - 4 February 2011, ITExpo, Miami,  USA
www.voice-system.ro


_______________________________________________
Users mailing list
[hidden email]
http://lists.opensips.org/cgi-bin/mailman/listinfo/users

_______________________________________________
Users mailing list
[hidden email]
http://lists.opensips.org/cgi-bin/mailman/listinfo/users

opensips_cap.txt (17K) Download Attachment
capture.txt (15K) Download Attachment
Reply | Threaded
Open this post in threaded view
|

Re: TCP timeout

Bogdan-Andrei Iancu
Hi Andrei,

Well, the trace looks good - I see the call is properly set up (INVITE +
200 OK + ACK), no retransmissions, no unusual stuff.

But for whatever reasons, the caller party sends a BYE....as the BYE
comes after 130 sec, I rule out a codec mismatch ...  Maybe a media
timeout ? do you have media in both direction during that 130 secs ?

Regards,
Bogdan

Andrei Bucur wrote:

> Hi Bogdan,
>
> I have the following topology:
>
> Nokia SIP client ------ router --------- OpenSIPS ---------- Asterisk
> 192.168.253.235     82.76.196.2 193.0.0.30
> 193.0.0.21
>
> I attached the captured files with opensips logs and packets on 193.0.0.30
> port 5060
>
> I belive ACK is not routed properly
>
> Thank you,
> Andrei
>
>
> -----Original Message-----
> From: [hidden email]
> [mailto:[hidden email]] On Behalf Of Bogdan-Andrei Iancu
> Sent: Friday, January 07, 2011 6:26 PM
> To: OpenSIPS users mailling list
> Subject: Re: [OpenSIPS-Users] TCP timeout
>
> Hi Andrei,
>
> which party do hang up the call ? caller? callee ? after the call setup
> (200 OK), do you any ACK from caller to callee ? Maybe the ACK is not
> properly routed to callee and callee fires a BYE request - maybe a sip
> capture from opensips machine will help.
>
> Regards,
> Bogdan
>
> Andrei Bucur wrote:
>  
>> Hi,
>>
>> I use opensips 1.6.4-notls and I configure it to listen on TCP 5060
>> and UDP
>> 5060
>> Everything is working ok on the UDP part but if using TCP 5060 the call
>> hangs up after about 130 sec
>>
>> The problem seems like to be tcpconn_timeout:
>>
>>    
> ============================================================================
> ======================
>  
>> Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]:
>> DBG:core:tcpconn_timeout: timeout for hash=2 - 0x7ff3d90703d0 (2816 >
>> 2811)
>> Jan  7 11:03:14 proxy /usr/local/sbin/opensips[15892]:
>> DBG:core:io_watch_del: io_watch_del (0x762c20, 40, -1, 0x10) fd_no=30
>> called
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
>> DBG:core:print_ip: tcpconn_new: new tcp connection to: 192.168.231.55
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
>> DBG:core:tcpconn_new: on port 33598, type 2
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
>> DBG:core:tcpconn_add: hashes: 255, 3
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
>> DBG:core:handle_new_connect: new connection: 0x7ff3d90703d0 40 flags: 0002
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15892]:
>> DBG:core:send2child: to tcp child 0 0(15882), 0x7ff3d90703d0
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:handle_io: received n=8 con=0x7ff3d90703d0, fd=36
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:io_watch_add: io_watch_add(0x762d80, 36, 2, 0x7ff3d90703d0),
>> fd_no=1
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:tcp_read_req: content-length= 0
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:parse_msg: SIP Request:
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:parse_msg:  method:  <BYE>
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:parse_msg:  uri:     <sip:*43@192.168.230.21>
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:parse_msg:  version: <SIP/2.0>
>> Jan  7 11:03:15 proxy /usr/local/sbin/opensips[15882]:
>> DBG:core:parse_headers: flags=2
>>
>>    
> ============================================================================
> ======================
>  
>>  
>> Any suggestion ?
>> Thank you,
>> Andrei
>>    

--
Bogdan-Andrei Iancu
OpenSIPS Event - expo, conf, social, bootcamp
2 - 4 February 2011, ITExpo, Miami,  USA
www.voice-system.ro


_______________________________________________
Users mailing list
[hidden email]
http://lists.opensips.org/cgi-bin/mailman/listinfo/users