[hylafax-users] T.30 T2 timeout, expected page not received

[Dominik Faessler <dominik.faessler@haenseler.ch>]

Title: T.30 T2 timeout, expected page not received

Hi

We have installed the newest version (4.5.1) on SuSE Linux 8.0 and the most faxdocuments can be received. About 1% - 2% cann't be received due to a T.30 T2 timout error. We use a Zyxel U-90E which is the follow-up model of the 1496E.

We have testet the configuration with the Class1TCFRecvHack, but this will not work properly because most documents will be aborted with the error 'waiting for v.21 carrier'.

Thank you for the help.

Dominik Fässler

This is our config-file:

CountryCode:            41
AreaCode:               71
FAXNumber:              "+41.71.3535800"
LongDistancePrefix:     0
InternationalPrefix:    00
DialStringRules:        etc/dialrules
ServerTracing:          0xfff
SessionTracing:         0xfff
RecvFileMode:           0644
LogFileMode:            0600
DeviceMode:             0666
RingsBeforeAnswer:      1
SpeakerVolume:          off
GettyArgs:              "-f -b -s %s %l"
LocalIdentifier:        "Haenseler AG"
#
#
# Modem-related stuff: should reflect modem command interface
# and hardware connection/cabling (e.g. flow control).
#
ModemType:              Class1          # use this to supply a hint
ModemRate:              19200           # rate for DCE-DTE communication
ModemFlowControl:       rtscts          # XON/XOFF flow control assumed
#
ModemSetupDTRCmd:       AT&D2           # setup so DTR drop resets modem
ModemSetupDCDCmd:       AT&C1           # setup so DCD follows carrier
ModemSetupAACmd:        AT+FAA=0
#GettyArgs:             "-h %l dx_%s"   # modem must auto-detect fax/data
#
# We can append the "@" symbol to the dial string so that
# the modem will wait 5 seconds before attempting to connect
# and return result codes that distinguish between no carrier
# and no answer.  This makes it possible to avoid problems with
# repeatedly dialing a number that doesn't have a fax machine
# (kudos to Stuart Lynne for this trick.)
#
# NB: If you need to prefix phone numbers to get through a PBX,
#     put it in the ModemDialCmd; e.g. "DT9%s@".
#
ModemDialCmd:           ATDT0%s         # T for tone dialing
NoCarrierRetrys:        3
#
# Other possible configuration stuff.  The default strings are
# shown below.  Only those that are different from the defaults
# need to be included in the configuration file.
#
ModemResetCmds:         "AT&B1&N0&S0*F0S38.3=1"         # stuff to do when modem is reset
#ModemAnswerCmd:                ATA             # use this to answer phone
ModemNoFlowCmd:         AT&H0           # disable flow control cmd
ModemHardFlowCmd:       AT&H3           # hardware flow control cmd
ModemSoftFlowCmd:       AT&H4           # software flow control cmd
#ModemNoAutoAnswerCmd:  ATS0=0          # disable auto-answer
#
# Set modem speaker volume commands: OFF QUIET LOW MEDIUM HIGH.
# Note that we both turn the speaker on/off and set volume.
#
ModemSetVolumeCmd:      "ATM0 ATM1L1 ATM1L3 ATM1L5 ATM1L7"
#ModemEchoOffCmd:       ATE0            # disable command echo
#ModemVerboseResultsCmd:        ATV1            # enable verbose command results
#ModemResultCodesCmd:   ATQ0            # enable result codes
#ModemOnHookCmd:                ATH0            # place phone on hook (hangup)
#ModemSoftResetCmd:     ATZ             # do soft reset of modem
#ModemSoftResetCmdDelay:        3000    # pause after soft reset
#ModemWaitTimeCmd:      ATS7=60         # wait 60 seconds for carrier
#ModemCommaPauseTimeCmd:        ATS8=2          # comma pause time is 2 seconds
#ModemRecvFillOrder:    LSB2MSB         # bit order of received facsimile
#ModemSendFillOrder:    LSB2MSB         # bit order modem expects for transmit
#
ModemMfrQueryCmd:       AT+FMFR?
ModemModelQueryCmd:     "!"
ModemRevQueryCmd:       AT+FREV?
#
Class1Cmd:              AT+FCLASS=1.0   # command to enter class 1
Class1PPMWaitCmd:       AT+FTS=7        # command to stop and wait before PPM
Class1TCFWaitCmd:       AT+FTS=7        # command to stop and wait before TCF
#Class1EOPWaitCmd:      AT+FTS=9        # command to stop and wait before EOP
Class1EOPWaitCmd:       AT+FTS=10       # command to stop and wait before EOP
Class1MsgRecvHackCmd:   ""      # command to avoid +FCERROR before image
Class1TCFResponseDelay: 75              # 75ms delay between recv TCF & response
Class1SendMsgDelay:     75              # 75ms delay after training
Class1SwitchingCmd:     AT+FRS=7        # silence between HDLC recv and trans
Class1TrainingRecovery: 1500            # 1.5sec delay after training failure
Class1RecvAbortOK:      200             # wait 200ms for abort response
Class1FrameOverhead:    2
Class1RecvIdentTimer:   40000           # 35+5secs waiting for ident frames
Class1TCFMaxNonZero:    10              # max 10% of data may be non-zero
Class1TCFMinRun:        1000            # min run is 2/3rds of TCF duration
Class1SwitchingDelay:   1000            # default 150 neu 75
#
#PagerSetupCmds:                AT&K0&N15       # use V.22 at 1200 bps (PageNet)
#
#FaxT2Timer             9000
#Class1TCFRecvHack:     yes
Class2DCCQueryCmd:      "!(0,1),(0-7),(0-4),(0-2),(0),(0),(0),(0-7)"
#

This is a sample T.30 T2 error file:

Apr 26 14:51:13.84: [15338]: SESSION BEGIN 00006901 41713535800
Apr 26 14:51:13.84: [15338]: HylaFAX (tm) Version 4.1.5
Apr 26 14:51:13.84: [15338]: <-- [4:ATA\r]
Apr 26 14:51:20.54: [15338]: --> [7:CONNECT]
Apr 26 14:51:20.54: [15338]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Apr 26 14:51:20.54: [15338]: STATE CHANGE: ANSWERING -> RECEIVING
Apr 26 14:51:20.54: [15338]: MODEM input buffering enabled
Apr 26 14:51:20.54: [15338]: RECV FAX: begin
Apr 26 14:51:20.54: [15338]: MODEM input buffering disabled
Apr 26 14:51:20.54: [15338]: <-- HDLC<23:FF C0 02 E2 82 04 4E A6 36 A6 CE 76 A6 86 12 04 04 04 04 04 04 04 04>
Apr 26 14:51:20.54: [15338]: <-- data [23]
Apr 26 14:51:20.54: [15338]: <-- data [2]
Apr 26 14:51:21.56: [15338]: --> [7:CONNECT]
Apr 26 14:51:21.56: [15338]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03 C0>
Apr 26 14:51:21.56: [15338]: <-- data [10]
Apr 26 14:51:21.56: [15338]: <-- data [2]
Apr 26 14:51:22.00: [15338]: --> [2:OK]
Apr 26 14:51:22.00: [15338]: <-- [9:AT+FRH=3\r]
Apr 26 14:51:22.31: [15338]: --> [7:CONNECT]
Apr 26 14:51:23.81: [15338]: --> HDLC<23:FF C0 C2 EC 2C 04 AC 2C 04 8C 2C 9C 04 8C 04 8C 2C 0C 0C 04 04 04 04>
Apr 26 14:51:23.81: [15338]: --> [2:OK]
Apr 26 14:51:23.81: [15338]: REMOTE TSI "0041 1 941 45 47"
Apr 26 14:51:23.81: [15338]: <-- [9:AT+FRH=3\r]
Apr 26 14:51:23.85: [15338]: --> [7:CONNECT]
Apr 26 14:51:24.07: [15338]: --> HDLC<7:FF C8 C1 00 45 19 00>
Apr 26 14:51:24.07: [15338]: --> [2:OK]
Apr 26 14:51:24.07: [15338]: REMOTE wants 14400 bit/s
Apr 26 14:51:24.07: [15338]: REMOTE wants page width 1728 pixels in 215 mm
Apr 26 14:51:24.07: [15338]: REMOTE wants unlimited page length
Apr 26 14:51:24.07: [15338]: REMOTE wants 3.85 line/mm
Apr 26 14:51:24.07: [15338]: REMOTE wants 2-D MR
Apr 26 14:51:24.07: [15338]: RECV training at v.17 14400 bit/s
Apr 26 14:51:24.07: [15338]: <-- [11:AT+FRM=145\r]
Apr 26 14:51:25.76: [15338]: --> [7:CONNECT]
Apr 26 14:51:27.27: [15338]: RECV: TCF 2763 bytes, 0% non-zero, 2692 zero-run
Apr 26 14:51:27.27: [15338]: --> [10:NO CARRIER]
Apr 26 14:51:27.27: [15338]: DELAY 75 ms
Apr 26 14:51:27.35: [15338]: TRAINING succeeded
Apr 26 14:51:27.35: [15338]: <-- [9:AT+FTH=3\r]
Apr 26 14:51:28.48: [15338]: --> [7:CONNECT]
Apr 26 14:51:28.48: [15338]: <-- HDLC<3:FF C8 21>
Apr 26 14:51:28.48: [15338]: <-- data [3]
Apr 26 14:51:28.48: [15338]: <-- data [2]
Apr 26 14:51:28.73: [15338]: --> [2:OK]
Apr 26 14:51:28.73: [15338]: MODEM input buffering enabled
Apr 26 14:51:28.73: [15338]: <-- [11:AT+FRM=146\r]
Apr 26 14:51:29.54: [15338]: --> [7:CONNECT]
Apr 26 14:51:29.54: [15338]: RECV: begin page
Apr 26 14:51:39.44: [15338]: RECV/CQ: Bad 1D pixel count, row 545, got 0, expected 1728
Apr 26 14:51:39.44: [15338]: RECV/CQ: Bad 1D pixel count, row 546, got 0, expected 1728
Apr 26 14:51:39.44: [15338]: RECV/CQ: Bad 1D pixel count, row 547, got 0, expected 1728
Apr 26 14:51:39.44: [15338]: RECV/CQ: Bad 1D pixel count, row 548, got 0, expected 1728
Apr 26 14:51:39.44: [15338]: RECV/CQ: Bad 1D pixel count, row 549, got 0, expected 1728
Apr 26 14:51:39.44: [15338]: RECV/CQ: Bad 1D pixel count, row 550, got 965, expected 1728
Apr 26 14:51:39.44: [15338]: RECV/CQ: Adjusting for trailing noise (6 run)
Apr 26 14:51:39.44: [15338]: RECV: 545 total lines, 0 bad lines, 0 consecutive bad lines
Apr 26 14:51:39.44: [15338]: RECV: end page
Apr 26 14:51:39.44: [15338]: --> [10:NO CARRIER]
Apr 26 14:51:39.44: [15338]: MODEM input buffering disabled
Apr 26 14:51:39.44: [15338]: <-- [9:AT+FRH=3\r]
Apr 26 14:52:19.44: [15338]: --> [0:]
Apr 26 14:52:19.44: [15338]: MODEM <Empty line>
Apr 26 14:52:19.44: [15338]: MODEM TIMEOUT: waiting for v.21 carrier
Apr 26 14:52:19.44: [15338]: <-- data [1]
Apr 26 14:52:19.45: [15338]: --> [2:OK]
Apr 26 14:52:19.45: [15338]: RECV FAX (00006901): recvq/fax06695.tif from 0041 1 941 45 47, route to <unspecified>, 0 pages in 0:59

Apr 26 14:52:19.45: [15338]: RECV FAX: T.30 T2 timeout, expected page not received
Apr 26 14:52:19.45: [15338]: <-- [9:AT+FTH=3\r]
Apr 26 14:52:20.49: [15338]: --> [7:CONNECT]
Apr 26 14:52:20.49: [15338]: <-- HDLC<3:FF C8 5F>
Apr 26 14:52:20.49: [15338]: <-- data [3]
Apr 26 14:52:20.49: [15338]: <-- data [2]
Apr 26 14:52:20.73: [15338]: --> [2:OK]
Apr 26 14:52:20.73: [15338]: MODEM input buffering enabled
Apr 26 14:52:20.73: [15338]: RECV FAX (00006901): session with 0041 1 941 45 47 terminated abnormally: T.30 T2 timeout, expected page not received

Apr 26 14:52:20.73: [15338]: RECV FAX: bin/faxrcvd "recvq/fax06695.tif" "ttyS0" "00006901" "T.30 T2 timeout, expected page not received" "" ""

Apr 26 14:52:21.68: [15338]: RECV FAX: end
Apr 26 14:52:21.68: [15338]: SESSION END