Hi,
I have had an issue pop up sometime in the last week or so.
I keep getting 'sip_reg_timeout' on all my trunks and extensions, every now and then.
This has caused an active call to just go silent.
These timeouts last from a couple of minutes to around an hour,
and then everything connects again and all is OK.
Here is the asterisk console log of my most recent hit which only lasted a couple of minutes :-
[root@l1nuxsvr ~]# asterisk -rvvvvvvv
Asterisk 1.4.17, Copyright (C) 1999 - 2007 Digium, Inc. and others.
Created by Mark Spencer <markster@digium.com>
Asterisk comes with ABSOLUTELY NO WARRANTY; type 'core show warranty' for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type 'core show license' for details.
=========================================================================
== Parsing '/etc/asterisk/asterisk.conf': Found
== Parsing '/etc/asterisk/extconfig.conf': Found
Connected to Asterisk 1.4.17 currently running on l1nuxsvr (pid = 4563)
Verbosity is at least 7
l1nuxsvr*CLI> sip show peers
Name/username Host Dyn Nat ACL Port Status
97951738/97951738 192.168.37.250 D 5061 OK (14 ms)
ft2609/87952609 202.86.50.100 5060 OK (28 ms)
ftel1901/87951901 202.86.50.100 5060 OK (27 ms)
ft1738/87951738 202.86.50.100 5060 OK (29 ms)
ft1708/87951708 202.86.50.100 5060 OK (30 ms)
ft0112/87950112 202.86.50.100 5060 OK (28 ms)
pt5551/61386835551 203.166.6.160 5060 OK (31 ms)
09109431/09109431 125.213.160.81 5060 OK (23 ms)
5010/Study 192.168.37.71 D 5060 OK (96 ms)
5009/Glen 192.168.37.252 D N 11065 OK (121 ms)
5008/HomePC (Unspecified) D 0 UNKNOWN
5007/Jo 192.168.37.252 D N 1088 OK (109 ms)
5005/Dani (Unspecified) D 0 UNKNOWN
5004/Matt (Unspecified) D 0 UNKNOWN
5000/homephone 192.168.37.250 D 5060 OK (6 ms)
15 sip peers [Monitored: 12 online, 3 offline Unmonitored: 0 online, 0 offline]
[Jan 27 09:33:13] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer '5007' is now UNREACHABLE! Last qualify: 107
Extension Changed 5007 new state Unavailable for Notify User Glen
[Jan 27 09:58:29] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87950112@sip.freshtel.net' timed out, trying again (Attempt #1)
[Jan 27 09:58:44] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87952609@sip.freshtel.net' timed out, trying again (Attempt #1)
[Jan 27 09:58:59] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951901@sip.freshtel.net' timed out, trying again (Attempt #1)
[Jan 27 09:59:14] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951708@sip.freshtel.net' timed out, trying again (Attempt #1)
[Jan 27 09:59:44] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951738@sip.freshtel.net' timed out, trying again (Attempt #1)
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer '97951738' is now UNREACHABLE! Last qualify: 7
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer '5000' is now UNREACHABLE! Last qualify: 7
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer '09109431' is now UNREACHABLE! Last qualify: 25
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer 'ft2609' is now UNREACHABLE! Last qualify: 27
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer 'ftel1901' is now UNREACHABLE! Last qualify: 29
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer 'ft1738' is now UNREACHABLE! Last qualify: 26
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer 'ft1708' is now UNREACHABLE! Last qualify: 29
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer 'ft0112' is now UNREACHABLE! Last qualify: 27
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer 'pt5551' is now UNREACHABLE! Last qualify: 27
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer '5010' is now UNREACHABLE! Last qualify: 95
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:15655 sip_poke_noanswer: Peer '5009' is now UNREACHABLE! Last qualify: 104
Extension Changed 5000 new state Unavailable for Notify User Glen
Extension Changed 5010 new state Unavailable for Notify User Glen
[Jan 27 09:59:59] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87950112@sip.freshtel.net' timed out, trying again (Attempt #2)
[Jan 27 10:00:14] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87952609@sip.freshtel.net' timed out, trying again (Attempt #2)
[Jan 27 10:00:29] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951901@sip.freshtel.net' timed out, trying again (Attempt #2)
[Jan 27 10:00:44] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951708@sip.freshtel.net' timed out, trying again (Attempt #2)
[Jan 27 10:00:59] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '09109431@sip00.mynetfone.com.au' timed out, trying again (Attempt #1)
-- Remote UNIX connection
-- Remote UNIX connection disconnected
-- Remote UNIX connection
-- Remote UNIX connection disconnected
-- Remote UNIX connection
-- Remote UNIX connection disconnected
[Jan 27 10:01:14] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951738@sip.freshtel.net' timed out, trying again (Attempt #2)
[Jan 27 10:01:29] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87950112@sip.freshtel.net' timed out, trying again (Attempt #3)
[Jan 27 10:01:44] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87952609@sip.freshtel.net' timed out, trying again (Attempt #3)
[Jan 27 10:01:59] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951901@sip.freshtel.net' timed out, trying again (Attempt #3)
[Jan 27 10:02:14] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951708@sip.freshtel.net' timed out, trying again (Attempt #3)
[Jan 27 10:02:25] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '09109431@sip00.mynetfone.com.au' timed out, trying again (Attempt #2)
[Jan 27 10:02:25] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87951738@sip.freshtel.net' timed out, trying again (Attempt #3)
[Jan 27 10:02:25] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87950112@sip.freshtel.net' timed out, trying again (Attempt #4)
[Jan 27 10:02:25] NOTICE[4671]: chan_sip.c:7422 sip_reg_timeout: -- Registration for '87952609@sip.freshtel.net' timed out, trying again (Attempt #4)
-- Registered SIP '5000' at 192.168.37.250 port 5060 expires 180
Extension Changed 5000 new state Idle for Notify User Glen
[Jan 27 10:02:25] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '5000' is now Reachable. (10ms / 3000ms)
-- Registered SIP '97951738' at 192.168.37.250 port 5061 expires 180
[Jan 27 10:02:26] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '97951738' is now Reachable. (10ms / 3000ms)
-- Registered SIP '5009' at 192.168.37.252 port 11069 expires 180
[Jan 27 10:02:26] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '5009' is now Reachable. (50ms / 3000ms)
-- Unregistered SIP '5009'
-- Registered SIP '5009' at 192.168.37.252 port 11069 expires 180
-- Saved useragent "X-Lite release 1011s stamp 41150" for peer 5009
[Jan 27 10:02:26] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '5009' is now Reachable. (4ms / 3000ms)
-- Registered SIP '5010' at 192.168.37.71 port 5060 expires 180
Extension Changed 5010 new state Idle for Notify User Glen
Extension Changed 5010 new state Idle for Notify User Glen
[Jan 27 10:02:27] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '5010' is now Reachable. (264ms / 3000ms)
[Jan 27 10:02:35] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '09109431' is now Reachable. (25ms / 3000ms)
[Jan 27 10:02:35] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer 'ft2609' is now Reachable. (30ms / 3000ms)
[Jan 27 10:02:35] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer 'ftel1901' is now Reachable. (35ms / 3000ms)
[Jan 27 10:02:35] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer 'ft1738' is now Reachable. (35ms / 3000ms)
[Jan 27 10:02:35] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer 'ft1708' is now Reachable. (40ms / 3000ms)
[Jan 27 10:02:35] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer 'pt5551' is now Reachable. (43ms / 3000ms)
[Jan 27 10:02:35] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer 'ft0112' is now Reachable. (47ms / 3000ms)
-- Registered SIP '5007' at 192.168.37.252 port 15730 expires 180
Extension Changed 5007 new state Idle for Notify User Glen
[Jan 27 10:14:46] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '5007' is now Reachable. (51ms / 3000ms)
-- Unregistered SIP '5007'
Extension Changed 5007 new state Unavailable for Notify User Glen
-- Registered SIP '5007' at 192.168.37.252 port 15730 expires 180
-- Saved useragent "X-Lite release 1011s stamp 41150" for peer 5007
Extension Changed 5007 new state Idle for Notify User Glen
[Jan 27 10:14:46] NOTICE[4671]: chan_sip.c:12517 handle_response_peerpoke: Peer '5007' is now Reachable. (6ms / 3000ms)
I do not lose internet connectivity at this time, So I cannot blame the ISP (also my extensions would not be hit if it was ISP)
This was happening while running sail 2.2.1-582, und I have upgraded to -587 last night without change.
asterisk-1.4.17-55.el4 and have been for a number of weeks, I only noticed this timeout issue in the last week or so.
Given the timing, it may be related to the recent sme 7.3 updates.
But I am at a loss to what is the cause or how to resolve,
any help would be great
(fortunately wife has not noticed yet)