Oct 3 19:06:25 VERBOSE[27650] logger.c: -- Accepting call from '' to '7475858' on channel 0/1, span 1
Oct 3 19:06:25 DEBUG[27650] chan_zap.c: Enabled echo cancellation on channel 1
Oct 3 19:06:25 VERBOSE[545] logger.c: -- Executing Set("Zap/1-1", "FROM_DID=7475858") in new stack
Oct 3 19:06:25 VERBOSE[545] logger.c: -- Executing Set("Zap/1-1", "FAX_RX=system") in new stack
Oct 3 19:06:25 VERBOSE[545] logger.c: -- Executing Set("Zap/1-1", "FAX_RX_EMAIL=tim@centrisys.com") in new stack
Oct 3 19:06:25 VERBOSE[545] logger.c: -- Executing Answer("Zap/1-1", "") in new stack
Oct 3 19:06:25 DEBUG[27642] channel.c: Avoiding initial deadlock for 'Zap/1-1'
Oct 3 19:06:25 VERBOSE[545] logger.c: -- Executing Wait("Zap/1-1", "10") in new stack
Oct 3 19:06:29 DEBUG[545] chan_zap.c: DTMF digit: f on Zap/1-1
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Redirecting Zap/1-1 to fax extension
Oct 3 19:06:29 VERBOSE[545] logger.c: == Spawn extension (from-pstn, fax, 0) exited non-zero on 'Zap/1-1'
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Executing Goto("Zap/1-1", "ext-fax|in_fax|1") in new stack
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Goto (ext-fax,in_fax,1)
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Executing StopPlayTones("Zap/1-1", "") in new stack
Oct 3 19:06:29 DEBUG[545] pbx.c: Expression result is '1'
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Executing GotoIf("Zap/1-1", "1?3:analog_fax|1") in new stack
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Goto (ext-fax,in_fax,3)
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Executing Macro("Zap/1-1", "faxreceive") in new stack
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Executing Set("Zap/1-1", "FAXFILE=/var/spool/asterisk/fax/1159923985.72.tif") in new stack
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Executing Set("Zap/1-1", "EMAILADDR=tim@centrisys.com") in new stack
Oct 3 19:06:29 WARNING[545] pbx.c: No application 'rxfax' for extension (macro-faxreceive, s, 3)
Oct 3 19:06:29 VERBOSE[545] logger.c: == Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1' in macro 'faxreceive'
Oct 3 19:06:29 VERBOSE[545] logger.c: == Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1'
Oct 3 19:06:29 DEBUG[545] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Oct 3 19:06:29 DEBUG[545] 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) VALUES ('2006-10-03 19:06:25','','','in_fax','ext-fax', 'Zap/1-1','','Set','EMAILADDR=tim@centrisys.com',4,4,'ANSWERED',3,'')
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '(null)'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '(null)'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is 'in_fax'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is 'ext-fax'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is 'Zap/1-1'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '(null)'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is 'Set'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is 'EMAILADDR=tim@centrisys.com'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '2006-10-03 19:06:25'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '2006-10-03 19:06:25'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '2006-10-03 19:06:29'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '4'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '4'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is 'ANSWERED'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is 'DOCUMENTATION'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '(null)'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '1159923985.72'
Oct 3 19:06:29 DEBUG[545] pbx.c: Function result is '(null)'
Oct 3 19:06:29 DEBUG[545] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/1-1
Oct 3 19:06:29 DEBUG[545] chan_zap.c: Hangup: channel: 1 index = 0, normal = 12, callwait = -1, thirdcall = -1
Oct 3 19:06:29 DEBUG[545] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call
Oct 3 19:06:29 DEBUG[545] chan_zap.c: disabled echo cancellation on channel 1
Oct 3 19:06:29 DEBUG[545] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Oct 3 19:06:29 DEBUG[545] chan_zap.c: Updated conferencing on 1, with 0 conference users
Oct 3 19:06:29 DEBUG[545] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/1-1
Oct 3 19:06:29 DEBUG[545] chan_zap.c: disabled echo cancellation on channel 1
Oct 3 19:06:29 VERBOSE[545] logger.c: -- Hungup 'Zap/1-1'
Oct 3 19:06:32 VERBOSE[27650] logger.c: -- Accepting call from '' to '7475858' on channel 0/1, span 1
Oct 3 19:06:32 DEBUG[27650] chan_zap.c: Enabled echo cancellation on channel 1
Oct 3 19:06:32 VERBOSE[549] logger.c: -- Executing Set("Zap/1-1", "FROM_DID=7475858") in new stack
Oct 3 19:06:32 VERBOSE[549] logger.c: -- Executing Set("Zap/1-1", "FAX_RX=system") in new stack
Oct 3 19:06:32 VERBOSE[549] logger.c: -- Executing Set("Zap/1-1", "FAX_RX_EMAIL=tim@centrisys.com") in new stack
Oct 3 19:06:32 VERBOSE[549] logger.c: -- Executing Answer("Zap/1-1", "") in new stack
Oct 3 19:06:32 DEBUG[27642] channel.c: Avoiding initial deadlock for 'Zap/1-1'
Oct 3 19:06:32 VERBOSE[549] logger.c: -- Executing Wait("Zap/1-1", "10") in new stack
-- Accepting call from '' to '7475858' on channel 0/1, span 1
-- Executing Set("Zap/1-1", "FROM_DID=7475858") in new stack
-- Executing Set("Zap/1-1", "FAX_RX=system") in new stack
-- Executing Set("Zap/1-1", "FAX_RX_EMAIL=tim@centrisys.com") in new stack
-- Executing Answer("Zap/1-1", "") in new stack
-- Executing Wait("Zap/1-1", "10") in new stack
-- Redirecting Zap/1-1 to fax extension
== Spawn extension (from-pstn, fax, 0) exited non-zero on 'Zap/1-1'
-- Executing Goto("Zap/1-1", "ext-fax|in_fax|1") in new stack
-- Goto (ext-fax,in_fax,1)
-- Executing StopPlayTones("Zap/1-1", "") in new stack
-- Executing GotoIf("Zap/1-1", "1?3:analog_fax|1") in new stack
-- Goto (ext-fax,in_fax,3)
-- Executing Macro("Zap/1-1", "faxreceive") in new stack
-- Executing Set("Zap/1-1", "FAXFILE=/var/spool/asterisk/fax/1159923985.72.tif") in new stack
-- Executing Set("Zap/1-1", "EMAILADDR=tim@centrisys.com") in new stack
== Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1' in macro 'faxreceive'
== Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1'
-- Hungup 'Zap/1-1'
-- Accepting call from '' to '7475858' on channel 0/1, span 1
-- Executing Set("Zap/1-1", "FROM_DID=7475858") in new stack
-- Executing Set("Zap/1-1", "FAX_RX=system") in new stack
-- Executing Set("Zap/1-1", "FAX_RX_EMAIL=tim@centrisys.com") in new stack
-- Executing Answer("Zap/1-1", "") in new stack
-- Executing Wait("Zap/1-1", "10") in new stack
-- Redirecting Zap/1-1 to fax extension
== Spawn extension (from-pstn, fax, 0) exited non-zero on 'Zap/1-1'
-- Executing Goto("Zap/1-1", "ext-fax|in_fax|1") in new stack
-- Goto (ext-fax,in_fax,1)
-- Executing StopPlayTones("Zap/1-1", "") in new stack
-- Executing GotoIf("Zap/1-1", "1?3:analog_fax|1") in new stack
-- Goto (ext-fax,in_fax,3)
-- Executing Macro("Zap/1-1", "faxreceive") in new stack
-- Executing Set("Zap/1-1", "FAXFILE=/var/spool/asterisk/fax/1159923992.73.tif") in new stack
-- Executing Set("Zap/1-1", "EMAILADDR=tim@centrisys.com") in new stack
== Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1' in macro 'faxreceive'
== Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1'
-- Hungup 'Zap/1-1'