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.<br>
Thanks soo much.<br>-braman<br>================================================== xxxxxxxxxx=calling number x'ed out for confidentiality prupose======<br>Mar 25 09:48:13 VERBOSE[3685] logger.c: -- Starting simple switch on 'Zap/4-1'<br>
Mar 25 09:48:14 DEBUG[3685] pbx.c: Function result is '"DEWOLFE ENG" <xxxxxxxxxx>'<br>
Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing NoOp("Zap/4-1",
">>>>>>>>> CallerID="DEWOLFE ENG" <xxxxxxxxxx>") in new stack<br>
Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing Answer("Zap/4-1", "") in new stack<br>
Mar 25 09:48:14 DEBUG[3685] chan_zap.c: Took Zap/4-1 off hook<br>
Mar 25 09:48:14 DEBUG[3685] chan_zap.c: Enabled echo cancellation on channel 4<br>
Mar 25 09:48:14 DEBUG[3685] chan_zap.c: Engaged echo training on channel 4<br>
Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing PlayTones("Zap/4-1", "ring") in new stack<br>
Mar 25 09:48:14 DEBUG[3685] channel.c: Scheduling timer at 160 sample intervals<br>
Mar 25 09:48:14 VERBOSE[3685] logger.c: -- Executing NVFaxDetect("Zap/4-1", "6") in new stack<br>
Mar 25 09:48:14 DEBUG[3685] app_nv_faxdetect.c: Preparing detect of fax (waitdur=6ms, sildur=1000ms, mindur=100ms, maxdur=-1ms)<br>
Mar 25 09:48:14 DEBUG[3685] channel.c: Generator got voice, switching to phase locked mode<br>
Mar 25 09:48:14 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals<br>
Mar 25 09:48:14 DEBUG[3685] app_nv_faxdetect.c: Start of voice token!<br>
Mar 25 09:48:15 DEBUG[3685] app_nv_faxdetect.c: Found unqualified token of 0 ms<br>
Mar 25 09:48:15 DEBUG[3685] app_nv_faxdetect.c: Start of voice token!<br>
Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Goto("Zap/4-1", "timeconditions|1|1") in new stack<br>
Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Goto (timeconditions,1,1)<br>
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<br>
Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Goto (ivr-4,s,1)<br>
Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "LOOPCOUNT=0") in new stack<br>
Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Answer("Zap/4-1", "") in new stack<br>
Mar 25 09:48:21 VERBOSE[3685] logger.c: -- Executing Wait("Zap/4-1", "1") in new stack<br>
Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(digit)=10") in new stack<br>
Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Digit timeout set to 10<br>
Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(response)=10") in new stack<br>
Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Response timeout set to 10<br>
Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Executing BackGround("Zap/4-1", "custom/RyderBrookWelcome") in new stack<br>
Mar 25 09:48:22 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals<br>
Mar 25 09:48:22 DEBUG[3685] channel.c: Scheduling timer at 160 sample intervals<br>
Mar 25 09:48:22 VERBOSE[3685] logger.c: -- Playing 'custom/RyderBrookWelcome' (language 'en')<br>
Mar 25 09:48:42 DEBUG[3685] channel.c: Scheduling timer at 58 sample intervals<br>
Mar 25 09:48:42 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals<br>
Mar 25 09:48:42 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Timeout on Zap/4-1<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: == CDR updated on Zap/4-1<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Goto("Zap/4-1", "loop|1") in new stack<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Goto (ivr-4,loop,1)<br>
Mar 25 09:48:53 DEBUG[3685] pbx.c: Expression result is '1'<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "LOOPCOUNT=1") in new stack<br>
Mar 25 09:48:53 DEBUG[3685] pbx.c: Expression result is '0'<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing GotoIf("Zap/4-1", "0?hang|1") in new stack<br>
Mar 25 09:48:53 DEBUG[3685] pbx.c: Not taking any branch<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Goto("Zap/4-1", "ivr-4|s|begin") in new stack<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Goto (ivr-4,s,4)<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(digit)=10") in new stack<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Digit timeout set to 10<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing Set("Zap/4-1", "TIMEOUT(response)=10") in new stack<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Response timeout set to 10<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Executing BackGround("Zap/4-1", "custom/RyderBrookWelcome") in new stack<br>
Mar 25 09:48:53 DEBUG[3685] channel.c: Scheduling timer at 160 sample intervals<br>
Mar 25 09:48:53 VERBOSE[3685] logger.c: -- Playing 'custom/RyderBrookWelcome' (language 'en')<br>
Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Exception on 13, channel 4<br>
Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Got event On hook(1) on channel 4 (index 0)<br>
Mar 25 09:48:59 DEBUG[3685] chan_zap.c: disabled echo cancellation on channel 4<br>
Mar 25 09:48:59 DEBUG[3685] channel.c: Scheduling timer at 0 sample intervals<br>
Mar 25 09:48:59 VERBOSE[3685] logger.c: == Spawn extension (ivr-4, s, 6) exited non-zero on 'Zap/4-1'<br>
Mar 25 09:48:59 VERBOSE[3685] logger.c: -- Executing Hangup("Zap/4-1", "") in new stack<br>
Mar 25 09:48:59 VERBOSE[3685] logger.c: == Spawn extension (ivr-4, h, 1) exited non-zero on 'Zap/4-1'<br>
Mar 25 09:48:59 DEBUG[3685] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.<br>
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')<br>
Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Hangup: channel: 4 index = 0, normal = 13, callwait = -1, thirdcall = -1<br>
Mar 25 09:48:59 DEBUG[3685] chan_zap.c: disabled echo cancellation on channel 4<br>
Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/4-1<br>
Mar 25 09:48:59 DEBUG[3685] chan_zap.c: Updated conferencing on 4, with 0 conference users<br>
Mar 25 09:48:59 VERBOSE[3685] logger.c: -- Hungup 'Zap/4-1'<br>==============================================================<br>