Feb 26 15:28:56 VERBOSE[4767] logger.c: -- Accepting voice call from '281' to '393' on channel 0/1, span 1
Feb 26 15:28:56 DEBUG[4767] chan_zap.c: Enabled echo cancellation on channel 1
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "DID=393") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Goto("Zap/1-1", "s|1") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Goto (from-zaptel,s,1)
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing NoOp("Zap/1-1", "Entering from-zaptel with DID == 393") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Ringing("Zap/1-1", "") in new stack
Feb 26 15:28:56 DEBUG[20762] chan_zap.c: Requested indication 3 on channel Zap/1-1
Feb 26 15:28:56 DEBUG[4744] channel.c: Avoiding initial deadlock for 'Zap/1-1'
Feb 26 15:28:56 DEBUG[20762] pbx.c: Expression result is '0'
Feb 26 15:28:56 DEBUG[20762] pbx.c: Function result is '393'
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "DID=393") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing NoOp("Zap/1-1", "DID is now 393") in new stack
Feb 26 15:28:56 DEBUG[20762] pbx.c: Expression result is '1'
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing GotoIf("Zap/1-1", "1?zapok:notzap") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Goto (from-zaptel,s,8)
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing NoOp("Zap/1-1", "Is a Zaptel Channel") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "CHAN=1-1") in new stack
Feb 26 15:28:56 DEBUG[20762] pbx.c: Function result is '1'
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "CHAN=1") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Macro("Zap/1-1", "from-zaptel-1|393|1") in new stack
Feb 26 15:28:56 WARNING[20762] app_macro.c: No such context 'macro-from-zaptel-1' for macro 'from-zaptel-1'
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing NoOp("Zap/1-1", "Returned from Macro from-zaptel-1") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Goto("Zap/1-1", "from-pstn|393|1") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Goto (from-pstn,393,1)
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing NoOp("Zap/1-1", "Catch-All DID Match - Found 393 - You probably want a DID for this.") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Goto("Zap/1-1", "ext-did|s|1") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Goto (ext-did,s,1)
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "FROM_DID=s/281") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "FAX_RX=system") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "FAX_RX_EMAIL=EMAIL@EMAIL") in new stack
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Answer("Zap/1-1", "") in new stack
Feb 26 15:28:56 DEBUG[4744] channel.c: Avoiding initial deadlock for 'Zap/1-1'
Feb 26 15:28:56 DEBUG[20762] chan_zap.c: Engaged echo training on channel 1
Feb 26 15:28:56 VERBOSE[20762] logger.c: -- Executing Wait("Zap/1-1", "6") in new stack
Feb 26 15:28:58 DEBUG[20762] chan_zap.c: DTMF digit: f on Zap/1-1
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Redirecting Zap/1-1 to fax extension
Feb 26 15:28:58 VERBOSE[20762] logger.c: == Spawn extension (ext-did, fax, 0) exited non-zero on 'Zap/1-1'
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Executing Goto("Zap/1-1", "ext-fax|in_fax|1") in new stack
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Goto (ext-fax,in_fax,1)
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Executing StopPlayTones("Zap/1-1", "") in new stack
Feb 26 15:28:58 DEBUG[20762] pbx.c: Expression result is '1'
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Executing GotoIf("Zap/1-1", "1?3:analog_fax|1") in new stack
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Goto (ext-fax,in_fax,3)
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Executing Macro("Zap/1-1", "faxreceive") in new stack
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "FAXFILE=/var/spool/asterisk/fax/asterisk-4724-1172500136.871.tif") in new stack
Feb 26 15:28:58 VERBOSE[20762] logger.c: -- Executing Set("Zap/1-1", "[email protected]") in new stack
Feb 26 15:28:58 WARNING[20762] pbx.c: No application 'rxfax' for extension (macro-faxreceive, s, 3)
Feb 26 15:28:58 VERBOSE[20762] logger.c: == Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1' in macro 'faxreceive'
Feb 26 15:28:58 VERBOSE[20762] logger.c: == Spawn extension (macro-faxreceive, s, 3) exited non-zero on 'Zap/1-1'