SOFTWARE FreePBX 2.1.3 CentOS 4.4 Asterisk 1.2.13 Zaptel 1.2.10 Sangoma Wanpipe 2.3.4.5 I had an Asterisk server lock up on me today after 95 days of up time. Had to manually kill the Asterisk process and then restart. Nothing out of the ordinary in terms of memory use as far as I could tell. Seems to be running fine now. Here is the log file. I deleted the stuff in the middle to keep it brief. The very last entry is where it locked up and stopped logging/responding. Anyone know what this might be? May 2 11:38:02 VERBOSE[10853] logger.c: -- Playing 'vm-press' (language 'en') May 2 11:38:02 DEBUG[10853] channel.c: Scheduling timer at 0 sample intervals May 2 11:38:02 DEBUG[10853] app.c: Locked path '/var/spool/asterisk/voicemail/default/660/INBOX' May 2 11:38:02 DEBUG[10853] app.c: Unlocked path '/var/spool/asterisk/voicemail/default/660/INBOX' May 2 11:38:02 DEBUG[10853] app.c: Locked path '/var/spool/asterisk/voicemail/default/660/Cust3' May 2 11:38:02 DEBUG[10853] app.c: Unlocked path '/var/spool/asterisk/voicemail/default/660/Cust3' May 2 11:38:02 DEBUG[10853] app.c: Locked path '/var/spool/asterisk/voicemail/default/660/Cust3' May 2 11:38:02 DEBUG[10853] app.c: Unlocked path '/var/spool/asterisk/voicemail/default/660/Cust3' May 2 11:38:02 DEBUG[10853] channel.c: Scheduling timer at 160 sample intervals May 2 11:38:02 VERBOSE[10853] logger.c: -- Playing 'vm-Cust3' (language 'en') May 2 11:38:12 DEBUG[10853] channel.c: Scheduling timer at 0 sample intervals May 2 11:38:12 DEBUG[10853] channel.c: Scheduling timer at 0 sample intervals May 2 11:38:12 VERBOSE[10853] logger.c: == Parsing '/var/spool/asterisk/voicemail/default/660/Cust3/msg0000.txt': May 2 11:38:12 VERBOSE[10853] logger.c: == Parsing '/var/spool/asterisk/voicemail/default/660/Cust3/msg0000.txt': Found May 2 11:38:12 DEBUG[10853] app_voicemail.c: VM-Duration: duration is: 48 seconds converted to: 0 minutes May 2 11:38:12 DEBUG[10853] channel.c: Scheduling timer at 160 sample intervals May 2 11:38:14 VERBOSE[10853] logger.c: -- Playing 'vm-deleted' (language 'en') May 2 11:38:14 DEBUG[3778] chan_sip.c: Stopping retransmission on 'ae9ff3814cc6ecc905ac93af7ed1f647@192.168.125.109' of Request 9948: Match Found May 2 11:38:14 DEBUG[3778] chan_sip.c: Stopping retransmission on '0142e3688d28a33bb8dc15ded295c8f9@192.168.125.109' of Request 9820: Match Found May 2 11:38:16 VERBOSE[10853] logger.c: -- Playing 'vm-message' (language 'en') May 2 11:38:17 DEBUG[10853] channel.c: Scheduling timer at 0 sample intervals May 2 11:38:17 DEBUG[10853] channel.c: Scheduling timer at 0 sample intervals May 2 11:38:17 VERBOSE[10853] logger.c: == Parsing '/var/spool/asterisk/voicemail/default/660/Cust3/msg0001.txt': May 2 11:38:17 VERBOSE[10853] logger.c: == Parsing '/var/spool/asterisk/voicemail/default/660/Cust3/msg0001.txt': Found May 2 11:38:17 DEBUG[10853] app_voicemail.c: VM-Duration: duration is: 27 seconds converted to: 0 minutes May 2 11:38:17 DEBUG[10853] channel.c: Scheduling timer at 160 sample intervals May 2 11:38:17 VERBOSE[10853] logger.c: -- Playing '/var/spool/asterisk/voicemail/default/660/Cust3/msg0001' (language 'en') May 2 11:38:24 VERBOSE[10853] logger.c: -- Playing 'vm-goodbye' (language 'en') May 2 11:38:25 DEBUG[10853] channel.c: Scheduling timer at 0 sample intervals May 2 11:38:25 DEBUG[10853] channel.c: Scheduling timer at 0 sample intervals May 2 11:38:25 DEBUG[10853] app.c: Locked path '/var/spool/asterisk/voicemail/default/660/Cust3' May 2 11:38:25 DEBUG[10853] app.c: Unlocked path '/var/spool/asterisk/voicemail/default/660/Cust3'
Well, asterisk was working without flaws until just a few minutes ago. Asterisk stayed running, but we were just getting dead air when you'd pick up the phone and you defiantly couldn't send/receive calls. I looked at the call detail, and there isn't anything abnormal there. I then looked at the /var/log/asterisk/messages file and saw this: May 29 13:45:28 WARNING[6766] channel.c: Avoided initial deadlock for '0x823b510', 10 retries! May 29 13:45:29 WARNING[6766] channel.c: Avoided initial deadlock for '0x8233518', 10 retries! May 29 13:45:29 WARNING[6766] channel.c: Avoided initial deadlock for '0x82608a8', 10 retries! May 29 13:45:29 WARNING[6766] channel.c: Avoided initial deadlock for '0x81bca10', 10 retries! May 29 13:45:29 WARNING[6766] channel.c: Avoided initial deadlock for '0x8293200', 10 retries! May 29 14:04:02 WARNING[8609] app_voicemail.c: Couldn't read username May 29 14:38:14 WARNING[6766] channel.c: Avoided initial deadlock for '0x8293200', 10 retries! May 29 14:38:14 WARNING[6766] channel.c: Avoided initial deadlock for '0x81c7d30', 10 retries! May 29 14:38:14 WARNING[6766] channel.c: Avoided initial deadlock for '0x823ea20', 10 retries! May 29 14:38:14 WARNING[6766] channel.c: Avoided initial deadlock for '0x8233518', 10 retries! May 29 14:50:34 WARNING[9519] chan_iax2.c: No such host: 5051 May 29 14:50:43 WARNING[9522] channel.c: Avoided deadlock for '0xb713d598', 10 retries! May 29 14:51:52 NOTICE[9668] cdr.c: CDR simple logging enabled. May 29 14:51:52 WARNING[9668] res_indications.c: Unable to set the default country (for indication tones) May 29 14:51:52 NOTICE[9668] config.c: Registered Config Engine mysql May 29 14:51:53 NOTICE[9668] chan_agent.c: Agents successfully reloaded from database. May 29 14:52:49 NOTICE[9692] chan_sip.c: Auto-congesting SIP/5052-0820c290 Would any of this bomb asterisk? If so, where should I look to fix these errors, etc? Your help is always much appreciated! Rob