[Asterisk-Users] Not receiving fax

Wayne Gemmell waynetg at telkomsa.net
Wed Nov 23 14:07:14 MST 2005


Hi all

I'm having trouble receiving faxes using rxfax. Could somebody please browse 
my log file and give me a swift kick in the right direction? I've also added 
my zapata.conf file at the end. 

I tried adjusting the rxgain to 15 (as mentioned in the archives) but that 
didn't seem to make a difference. I've turned of my busydetect in case it is 
hanging up too soon.

I'm running asterisk 1.2 and spandsp 0.0.2pre21

<full log>
Nov 23 22:34:51 DEBUG[3374] chan_sip.c: Stopping retransmission on 
'113660c91a0d9a8a4a1b53de679f2ae6 at 192.168.2.2' of Request 102: Match Found
Nov 23 22:34:59 DEBUG[3374] chan_sip.c: Auto destroying call 
'fd673861707b3ca9 at 192.168.2.201'
Nov 23 22:35:43 DEBUG[3373] dsp.c: dsp busy pattern set to 0,0
Nov 23 22:35:43 VERBOSE[6125] logger.c:     -- Starting simple switch on 
'Zap/1-1'
Nov 23 22:35:43 NOTICE[6125] chan_zap.c: Got event 18 (Ring Begin)...
Nov 23 22:35:44 NOTICE[6125] chan_zap.c: Got event 2 (Ring/Answered)...
Nov 23 22:35:46 NOTICE[6125] chan_zap.c: Got event 18 (Ring Begin)...
Nov 23 22:35:46 NOTICE[6125] chan_zap.c: Got event 2 (Ring/Answered)...
Nov 23 22:35:47 NOTICE[6125] chan_zap.c: Got event 18 (Ring Begin)...
Nov 23 22:35:47 NOTICE[6125] chan_zap.c: Got event 2 (Ring/Answered)...
Nov 23 22:35:49 NOTICE[6125] chan_zap.c: Got event 18 (Ring Begin)...
Nov 23 22:35:49 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?from-pstn-reghours|s|1:") in new stack
Nov 23 22:35:49 DEBUG[6125] pbx.c: Not taking any branch
Nov 23 22:35:49 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?from-pstn-afthours|s|1:") in new stack
Nov 23 22:35:49 DEBUG[6125] pbx.c: Not taking any branch
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Executing GotoIfTime("Zap/1-1", 
"7:55-17:05|mon-fri|*|*?from-pstn-reghours|s|1:") in new stack
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Executing Goto("Zap/1-1", 
"from-pstn-afthours|s|1") in new stack
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Goto (from-pstn-afthours,s,1)
Nov 23 22:35:49 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?from-pstn-afthours-nofax|s|1:2") in new stack
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Goto (from-pstn-afthours,s,2)
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Executing Answer("Zap/1-1", "") 
in new stack
Nov 23 22:35:49 DEBUG[6125] chan_zap.c: Took Zap/1-1 off hook
Nov 23 22:35:49 DEBUG[6125] chan_zap.c: Enabled echo cancellation on channel 1
Nov 23 22:35:49 DEBUG[6125] chan_zap.c: Engaged echo training on channel 1
Nov 23 22:35:49 VERBOSE[6125] logger.c:     -- Executing Wait("Zap/1-1", "1") 
in new stack
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing SetVar("Zap/1-1", 
"intype=aa_1") in new stack
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing Cut("Zap/1-1", 
"intype=intype|-|1") in new stack
Nov 23 22:35:50 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?7:9") in new stack
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Goto (from-pstn-afthours,s,9)
Nov 23 22:35:50 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?10:12") in new stack
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Goto (from-pstn-afthours,s,12)
Nov 23 22:35:50 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?13:15") in new stack
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Goto (from-pstn-afthours,s,15)
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing Goto("Zap/1-1", 
"aa_1|s|1") in new stack
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Goto (aa_1,s,1)
Nov 23 22:35:50 WARNING[6125] ast_expr2.fl: ast_yyerror(): syntax error: 
syntax error, unexpected TOK_EQ, expecting TOK_MINUS or TOK_COMPL or TOK_LP 
or TOKEN; Input:
 = ANSWER
 ^
Nov 23 22:35:50 WARNING[6125] ast_expr2.fl: If you have questions, please 
refer to doc/README.variables in the asterisk source.
Nov 23 22:35:50 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?4") in new stack
Nov 23 22:35:50 DEBUG[6125] pbx.c: Not taking any branch
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing Answer("Zap/1-1", "") 
in new stack
Nov 23 22:35:50 VERBOSE[6125] logger.c:     -- Executing Wait("Zap/1-1", "1") 
in new stack
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Executing SetVar("Zap/1-1", 
"LOOPED=1") in new stack
Nov 23 22:35:51 DEBUG[6125] pbx.c: Expression result is '0'
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"0?hang|1") in new stack
Nov 23 22:35:51 DEBUG[6125] pbx.c: Not taking any branch
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Executing SetVar("Zap/1-1", 
"DIR-CONTEXT=general") in new stack
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Executing 
DigitTimeout("Zap/1-1", "3") in new stack
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Set Digit Timeout to 3
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Executing 
ResponseTimeout("Zap/1-1", "7") in new stack
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Set Response Timeout to 7
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Executing BackGround("Zap/1-1", 
"custom/aa_1") in new stack
Nov 23 22:35:51 DEBUG[6125] channel.c: Scheduling timer at 160 sample 
intervals
Nov 23 22:35:51 VERBOSE[6125] logger.c:     -- Playing 'custom/aa_1' (language 
'en')
Nov 23 22:35:52 DEBUG[6125] chan_zap.c: DTMF digit: f on Zap/1-1
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Redirecting Zap/1-1 to fax 
extension
Nov 23 22:35:52 DEBUG[6125] channel.c: Scheduling timer at 0 sample intervals
Nov 23 22:35:52 VERBOSE[6125] logger.c:   == Spawn extension (aa_1, fax, 0) 
exited non-zero on 'Zap/1-1'
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Executing Goto("Zap/1-1", 
"ext-fax|in_fax|1") in new stack
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Goto (ext-fax,in_fax,1)
Nov 23 22:35:52 DEBUG[6125] pbx.c: Expression result is '1'
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Executing GotoIf("Zap/1-1", 
"1?2:analog_fax|1") in new stack
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Goto (ext-fax,in_fax,2)
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Executing Macro("Zap/1-1", 
"faxreceive") in new stack
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Executing SetVar("Zap/1-1", 
"FAXFILE=/var/spool/asterisk/fax/1132778143.93.tif") in new stack
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Executing SetVar("Zap/1-1", 
"EMAILADDR=root at localhost") in new stack
Nov 23 22:35:52 VERBOSE[6125] logger.c:     -- Executing RxFAX("Zap/1-1", 
"/var/spool/asterisk/fax/1132778143.93.tif") in new stack
Nov 23 22:35:52 DEBUG[6125] chan_zap.c: DTMF digit: f on Zap/1-1
Nov 23 22:35:52 DEBUG[6125] chan_zap.c: Fax already handled
Nov 23 22:36:12 DEBUG[6039] manager.c: Manager received command 'Command'
Nov 23 22:36:12 DEBUG[6039] manager.c: Manager received command 'Command'
Nov 23 22:36:30 DEBUG[3374] chan_sip.c: Stopping retransmission on 
'2351a0d92d13eb5339dc1c6b03a5fee0 at 192.168.2.2' of Request 102: Match Found
Nov 23 22:36:31 DEBUG[6125] dsp.c: ast_dsp_busydetect detected busy, avgtone: 
468, avgsilence 518
Nov 23 22:36:31 DEBUG[6125] dsp.c: Requesting Hangup because the busy tone was 
detected on channel Zap/1-1
Nov 23 22:36:31 DEBUG[6125] app_rxfax.c: Got hangup
Nov 23 22:36:31 DEBUG[6125] app_macro.c: Extension s, priority 3 returned 
normally even though call was hung up
Nov 23 22:36:31 DEBUG[6125] pbx.c: Extension in_fax, priority 2 returned 
normally even though call was hung up
Nov 23 22:36:31 VERBOSE[6125] logger.c:     -- Executing Hangup("Zap/1-1", "") 
in new stack
Nov 23 22:36:31 VERBOSE[6125] logger.c:   == Spawn extension (ext-fax, h, 1) 
exited non-zero on 'Zap/1-1'
Nov 23 22:36:31 DEBUG[6125] chan_zap.c: Hangup: channel: 1 index = 0, normal = 
17, callwait = -1, thirdcall = -1
Nov 23 22:36:31 DEBUG[6125] chan_zap.c: disabled echo cancellation on channel 
1
Nov 23 22:36:31 DEBUG[6125] chan_zap.c: Set option TDD MODE, value: OFF(0) on 
Zap/1-1
Nov 23 22:36:31 DEBUG[6125] chan_zap.c: Updated conferencing on 1, with 0 
conference users
Nov 23 22:36:31 VERBOSE[6125] logger.c:     -- Hungup 'Zap/1-1'
Nov 23 22:36:34 DEBUG[3374] chan_sip.c: Auto destroying call 
'fd673861707b3ca9 at 192.168.2.201'
</full log>

<zaptel.conf>
;
; Zapata telephony interface
;
; Configuration file

[trunkgroups]

[channels]

language=en
context=from-pstn
signalling=fxs_ks
rxwink=300              ; Atlas seems to use long (250ms) winks
;
; Whether or not to do distinctive ring detection on FXO lines
;
;usedistinctiveringdetection=yes

usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
echotraining=800
rxgain=15.0
txgain=0.0
group=0
callgroup=1
pickupgroup=1
immediate=no


;busydetect=yes
;busycount=15


faxdetect=incoming
</zaptel.conf>
-- 
Regards

Wayne Gemmell

Tel & Fax: (011) 894-4081
Cell  : 072 836 4325
Email  : waynetg at telkomsa.net




More information about the asterisk-users mailing list