After a power interruption, asterisk doesn't seem to be routing calls and there seems to be a premature timeout and hangups occurring. I am clueless where to look. Can someone in the know, look at the following log and enlighten me if there's a problem, or if it looks normal. From the calling phone, it keeps ringing as if never picked up. Thanks soo much. -braman ================================================== xxxxxxxxxx=calling number x'ed out for confidentiality prupose=====Mar 25 09:48:13 VERBOSE[3685] logger.c: -- Starting simple switch on 'Zap/4-1' Mar 25 09:48:14 DEBUG[3685] pbx.c: Function result is '"DEWOLFE ENG" <xxxxxxxxxx>' Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing NoOp("Zap/4-1", ">>>>>>>>> CallerID="DEWOLFE ENG" <xxxxxxxxxx>") in new stack Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing Answer("Zap/4-1", "") in new stack Mar 25 09:48:14 DEBUG[3685] chan_zap.c: Took Zap/4-1 off hook Mar 25 09:48:14 DEBUG[3685] chan_zap.c: Enabled echo cancellation on channel 4 Mar 25 09:48:14 DEBUG[3685] chan_zap.c: Engaged echo training on channel 4 Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing PlayTones("Zap/4-1", "ring") in new stack Mar 25 09:48:14 DEBUG[3685] channel.c: Scheduling timer at 160 sample intervals Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing NVFaxDetect("Zap/4-1", "6") in new stack Mar 25 09:48:14 DEBUG[3685] app_nv_faxdetect.c: Preparing detect of fax (waitdur=6ms, sildur=1000ms, mindur=100ms, maxdur=-1ms) Mar 25 09:48:14 DEBUG[3685] channel.c: Generator got voice, switching to phase locked mode Mar 25 09:48:14 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals Mar 25 09:48:14 DEBUG[3685] app_nv_faxdetect.c: Start of voice token! Mar 25 09:48:15 DEBUG[3685] app_nv_faxdetect.c: Found unqualified token of 0 ms Mar 25 09:48:15 DEBUG[3685] app_nv_faxdetect.c: Start of voice token! Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Goto("Zap/4-1", "timeconditions|1|1") in new stack Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Goto (timeconditions,1,1) Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing GotoIfTime("Zap/4-1", "08:00-12:00|mon-fri|*|*?ivr-4|s|1") in new stack Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Goto (ivr-4,s,1) Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "LOOPCOUNT=0") in new stack Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Answer("Zap/4-1", "") in new stack Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Wait("Zap/4-1", "1") in new stack Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(digit)=10") in new stack Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Digit timeout set to 10 Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(response)=10") in new stack Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Response timeout set to 10 Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Executing BackGround("Zap/4-1", "custom/RyderBrookWelcome") in new stack Mar 25 09:48:22 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals Mar 25 09:48:22 DEBUG[3685] channel.c: Scheduling timer at 160 sample intervals Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Playing 'custom/RyderBrookWelcome' (language 'en') Mar 25 09:48:42 DEBUG[3685] channel.c: Scheduling timer at 58 sample intervals Mar 25 09:48:42 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals Mar 25 09:48:42 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Timeout on Zap/4-1 Mar 25 09:48:53 VERBOSE[3685] logger.c: == CDR updated on Zap/4-1 Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Goto("Zap/4-1", "loop|1") in new stack Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Goto (ivr-4,loop,1) Mar 25 09:48:53 DEBUG[3685] pbx.c: Expression result is '1' Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "LOOPCOUNT=1") in new stack Mar 25 09:48:53 DEBUG[3685] pbx.c: Expression result is '0' Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing GotoIf("Zap/4-1", "0?hang|1") in new stack Mar 25 09:48:53 DEBUG[3685] pbx.c: Not taking any branch Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Goto("Zap/4-1", "ivr-4|s|begin") in new stack Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Goto (ivr-4,s,4) Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(digit)=10") in new stack Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Digit timeout set to 10 Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(response)=10") in new stack Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Response timeout set to 10 Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing BackGround("Zap/4-1", "custom/RyderBrookWelcome") in new stack Mar 25 09:48:53 DEBUG[3685] channel.c: Scheduling timer at 160 sample intervals Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Playing 'custom/RyderBrookWelcome' (language 'en') Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Exception on 13, channel 4 Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Got event On hook(1) on channel 4 (index 0) Mar 25 09:48:59 DEBUG[3685] chan_zap.c: disabled echo cancellation on channel 4 Mar 25 09:48:59 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals Mar 25 09:48:59 VERBOSE[3685] logger.c: == Spawn extension (ivr-4, s, 6) exited non-zero on 'Zap/4-1' Mar 25 09:48:59 VERBOSE[3685] logger.c: -- Executing Hangup("Zap/4-1", "") in new stack Mar 25 09:48:59 VERBOSE[3685] logger.c: == Spawn extension (ivr-4, h, 1) exited non-zero on 'Zap/4-1' Mar 25 09:48:59 DEBUG[3685] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record. Mar 25 09:48:59 DEBUG[3685] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode,uniqueid) VALUES ('2010-03-25 09:48:14','\"DEWOLFE ENG\" <xxxxxxxxxx>','xxxxxxxxxx','s','ivr-4', 'Zap/4-1','','Hangup','',45,45,'ANSWERED',3,'','1269524893.14') Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Hangup: channel: 4 index = 0, normal = 13, callwait = -1, thirdcall = -1 Mar 25 09:48:59 DEBUG[3685] chan_zap.c: disabled echo cancellation on channel 4 Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/4-1 Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Updated conferencing on 4, with 0 conference users Mar 25 09:48:59 VERBOSE[3685] logger.c: -- Hungup 'Zap/4-1' =============================================================-------------- next part -------------- An HTML attachment was scrubbed... URL: http://lists.digium.com/pipermail/asterisk-users/attachments/20100325/badae081/attachment.htm