[Asterisk-Users] Asterisk dies after 3-6 hours of operation. Help!

[Stephen Davies]

On Wed, 9 Apr 2003, Frank Hoonhout wrote:

>   It seems to run for about 3-6 hours, then the process stops.  I have
> noticed, that * does not stop, if I do NOT have it register to other sip
> servers. (FWD and PCH).
> 
> Here is are the last few lines in the /var/log/asterisk/messages log file.
> 
> Apr  9 04:15:24 NOTICE[147466]: File sched.c, Line 247 (ast_sched_del):
> Attempted to delete non-existant schedule entry 3211! Apr  9 04:16:49
> NOTICE[147466]: File chan_sip.c, Line 2498 (transmit_register): Scheduled a
> timeout # 3219 Apr  9 04:16:49 NOTICE[147466]: File chan_sip.c, Line 3816
> (handle_response): Registration successful Apr  9 04:16:49 NOTICE[147466]:
> File chan_sip.c, Line 3817 (handle_response): Cancelling timeout 3219 Apr  9
> 04:16:49 NOTICE[147466]: File sched.c, Line 247 (ast_sched_del): Attempted
> to delete non-existant schedule entry 3214! Apr  9 04:17:22 NOTICE[147466]:
> File chan_sip.c, Line 2498 (transmit_register): Scheduled a timeout # 3222
> Apr  9 04:17:28 WARNING[147466]: File chan_sip.c, Line 385 (retrans_pkt):
> Maximum retries exceeded on call 37ff464800093aa70bc795d40f884bfa @127.0.0.1
> for seqno 450 (Request) Apr  9 04:17:32 NOTICE[147466]: File chan_sip.c,
> Line 2456 (sip_reg_timeout): Registration timed out, trying again Apr  9
> 04:17:38 WARNING[147466]: File chan_sip.c, Line 385 (retrans_pkt): Maximum
> retries exceeded on call 37ff464800093aa70bc795d40f884bfa @127.0.0.1 for
> seqno 451 (Request)


There's definitely some memory overwrite or something - I assume in all 
the new SIP stuff.

Mine registers to FWD and Packet8.  * stops recognising the "200 OK" to
its REGISTERs, then starts sending packets to off places, then seg faults.

Here's an example:


-----------------------------------------------------------------
Reliably Transmitting:
REGISTER sip:4.42.235.170 SIP/2.0
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
User-Agent: Asterisk PBX
Expires: 120
Event: registration
Content-length: 0

 (no NAT) to 4.42.235.170:5060
Sip read:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>;expires=30
Expires: 30
Content-Length: 0


9 headers, 0 lines
Interface is eth2
IP Address is 81.96.69.210
Retransmitting #1 (no NAT):
REGISTER sip:4.42.235.170 SIP/2.0
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
User-Agent: Asterisk PBX
Expires: 120
Event: registration
Content-length: 0


 to 4.42.235.170:5060
Sip read:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>;expires=30
Expires: 30
Content-Length: 0


9 headers, 0 lines
Interface is eth2
IP Address is 81.96.69.210
Retransmitting #2 (no NAT):
REGISTER sip:4.42.235.170 SIP/2.0
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
User-Agent: Asterisk PBX
Expires: 120
Event: registration
Content-length: 0


 to 0.0.0.0:0
WARNING[5126]: File chan_sip.c, Line 363 (__sip_xmit): sip_xmit of
0x8103024 (len 409) to 0.0.0.0 returned -1: Invalid argument
Retransmitting #3 (no NAT):
REGISTER sip:4.42.235.170 SIP/2.0
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
User-Agent: Asterisk PBX
Expires: 120
Event: registration
Content-length: 0


 to 0.0.0.0:0
WARNING[5126]: File chan_sip.c, Line 363 (__sip_xmit): sip_xmit of
0x8103024 (len 409) to 0.0.0.0 returned -1: Invalid argument
Retransmitting #4 (no NAT):
REGISTER sip:4.42.235.170 SIP/2.0
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
User-Agent: Asterisk PBX
Expires: 120
Event: registration
Content-length: 0


 to 0.0.0.0:0
WARNING[5126]: File chan_sip.c, Line 363 (__sip_xmit): sip_xmit of
0x8103024 (len 409) to 0.0.0.0 returned -1: Invalid argument
Retransmitting #5 (no NAT):
REGISTER sip:4.42.235.170 SIP/2.0
Via: SIP/2.0/UDP 81.96.69.210:5062;branch=z9hG4bK5ed62f80
From: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
To: <sip:0403242876 at 4.42.235.170>;tag=as2c043dea
Contact: <sip:6001 at 81.96.69.210:5062;transport=udp>
Call-ID: 12a27417365fe7d42498ed1919e2a96e at 195.217.255.45
CSeq: 113 REGISTER
User-Agent: Asterisk PBX
Expires: 120
Event: registration
Content-length: 0


 to 0.0.0.0:0
WARNING[5126]: File chan_sip.c, Line 363 (__sip_xmit): sip_xmit of
0x8103024 (len 409) to 0.0.0.0 returned -1: Invalid argument
WARNING[5126]: File chan_sip.c, Line 387 (retrans_pkt): Maximum retries
exceeded on call  for seqno 113 (Request)
NOTICE[5126]: File sched.c, Line 247 (ast_sched_del): Attempted to delete
non-existant schedule entry 0!
NOTICE[5126]: File sched.c, Line 247 (ast_sched_del): Attempted to delete
non-existant schedule entry 0!
WARNING[5126]: File chan_sip.c, Line 796 (__sip_destroy): (nil) is not in
list?!?!
NOTICE[5126]: File chan_sip.c, Line 2470 (sip_reg_timeout): Registration
timed out, trying again
Reliably Transmitting:
REGISTER sip:4.42.235.170 SIP/2.0
Via: SIP/2.0/UDP 0.0.0.0:5062;branch=z9hG4bK00000000
From: <sip:0403242876 at 4.42.235.170>;tag=as00000000
To: <sip:0403242876 at 4.42.235.170>;tag=as00000000
Contact: <sip:6001 at 0.0.0.0:5062;transport=udp>
Call-ID:
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Expires: 120
Event: registration
Content-length: 0

 (no NAT) to 0.0.0.0:0
WARNING[5126]: File chan_sip.c, Line 363 (__sip_xmit): sip_xmit of
0x8108d74 (len 350) to 0.0.0.0 returned -1: Invalid argument
Segmentation fault
[root at bob asterisk]#
-----------------------------------------------------------------

Steve