Re: [hylafax-users] hylafax says RECV: reject TCF (too many non-zero, max 10%)

["Fourat Zouari" <fourat@xxxxxxxxx>]

here's the entire log :

-------------------------------------
mai 25 15:02:58.78: [13503]: SESSION BEGIN 000001618 21671786155
mai 25 15:02:58.78: [13503]: HylaFAX (tm) Version 4.2.1
mai 25 15:02:58.78: [13503]: <-- [4:ATA\r]
mai 25 15:03:04.16: [13503]: --> [7:CONNECT]
mai 25 15:03:04.16: [13503]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttySHSF1'
mai 25 15:03:04.16: [13503]: STATE CHANGE: ANSWERING -> RECEIVING
mai 25 15:03:04.16
: [13503]: MODEM input buffering enabled
mai 25 15:03:04.16: [13503]: RECV FAX: begin
mai 25 15:03:04.16: [13503]: MODEM input buffering disabled
mai 25 15:03:04.16: [13503]: <-- HDLC<32:FF C0 04 AD 00 55 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 4C 74 8C>
mai 25 15:03:04.16: [13503]: <-- data [32]
mai 25 15:03:04.16: [13503]: <-- data [2]
mai 25 15:03:05.83: [13503]: --> [7:CONNECT]
mai 25 15:03:05.83: [13503]: <-- HDLC<23:FF C0 02 2C 1C 1C 9C 1C EC 8C EC 6C 8C 4C D4 04 2A 82 92 42 82 04 04>
mai 25 15:03:05.83: [13503]: <-- data [23]
mai 25 15:03:05.83: [13503]: <-- data [2]
mai 25 15:03:06.52: [13503]: --> [7:CONNECT]
mai 25 15:03:06.52: [13503]: <-- HDLC<10:FF C8 01 00 76 5F 23 01 FB C0>
mai 25 15:03:06.52: [13503]: <-- data [10]
mai 25 15:03:06.52: [13503]: <-- data [2]
mai 25 15:03:07.14: [13503]: --> [2:OK]
mai 25 15:03:07.14: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:07.33: [13503]: --> [7:CONNECT]
mai 25 15:03:09.03: [13503]: --> HDLC<25:FF C0 C2 CC 0C 1C 04 9C 9C 4C 04 2C EC 04 04 04 04 04 04 04 04 04 04 07 9C>
mai 25 15:03:09.11: [13503]: --> [2:OK]
mai 25 15:03:09.11: [13503]: REMOTE TSI "22 409 302"
mai 25 15:03:09.11: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:09.14: [13503]: --> [7:CONNECT]
mai 25 15:03:09.41: [13503]: --> HDLC<11:FF C8 C1 00 60 15 01 01 00 0A 70>
mai 25 15:03:09.45: [13503]: --> [2:OK]
mai 25 15:03:09.45: [13503]: REMOTE wants 9600 bit/s
mai 25 15:03:09.45: [13503]: REMOTE wants A4 page width (215 mm)
mai 25 15:03:09.45: [13503]: REMOTE wants unlimited page length
mai 25 15:03:09.45: [13503]: REMOTE wants 
3.85 line/mm
mai 25 15:03:09.45: [13503]: REMOTE wants 1-D MH
mai 25 15:03:09.45: [13503]: RECV training at v.29 9600 bit/s
mai 25 15:03:09.45: [13503]: <-- [10:AT+FRM=96\r]
mai 25 15:03:09.75: [13503]: --> [7:CONNECT]
mai 25 15:03:11.30: [13503]: RECV: TCF 1812 bytes, 89% non-zero, 1 zero-run
mai 25 15:03:11.30: [13503]: RECV: reject TCF (too many non-zero, max 10%)
mai 25 15:03:11.30: [13503]: RECV: reject TCF (zero run too short, min 1200)
mai 25 15:03:11.33: [13503]: --> [10:NO CARRIER]
mai 25 15:03:11.33: [13503]: DELAY 75 ms
mai 25 15:03:11.40: [13503]: <-- [9:AT+FTH=3\r]
mai 25 15:03:11.72: [13503]: --> [7:CONNECT]
mai 25 15:03:
11.72: [13503]: <-- HDLC<3:FF C8 22>
mai 25 15:03:11.72: [13503]: <-- data [3]
mai 25 15:03:11.72: [13503]: <-- data [2]
mai 25 15:03:12.98: [13503]: --> [2:OK]
mai 25 15:03:12.98: [13503]: TRAINING failed
mai 25 15:03:12.98: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:14.08: [13503]: --> [7:CONNECT]
mai 25 15:03:15.79: [13503]: --> HDLC<25:FF C0 C2 CC 0C 1C 04 9C 9C 4C 04 2C EC 04 04 04 04 04 04 04 04 04 04 07 9C>
mai 25 15:03:15.87: [13503]: --> [2:OK]
mai 25 15:03:15.87: [13503]: REMOTE TSI "74 299 803"
mai 25 15:03:15.87: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:15.89: [13503]: --> [7:CONNECT]
mai 25 15:03:16.17: [13503]: --> HDLC<11:FF C8 C1 00 60 15 01 01 00 0A 70>
mai 25 15:03:16.20: [13503]: --> [2:OK]
mai 25 15:03:16.20: [13503]: REMOTE wants 9600 bit/s
mai 25 15:03:16.20: [13503]: REMOTE wants A4 page width (215 mm)
mai 25 15:03:16.20: [13503]: REMOTE wants unlimited page length
mai 25 15:03:16.20: [13503]: REMOTE wants 3.85 line/mm
mai 25 15:03:16.20: [13503]: REMOTE wants 1-D MH
mai 25 15:03:16.20: [13503]: RECV training at 
v.29 9600 bit/s
mai 25 15:03:16.20: [13503]: <-- [10:AT+FRM=96\r]
mai 25 15:03:16.50: [13503]: --> [7:CONNECT]
mai 25 15:03:18.06: [13503]: RECV: TCF 1812 bytes, 91% non-zero, 1 zero-run
mai 25 15:03:18.06
: [13503]: RECV: reject TCF (too many non-zero, max 10%)
mai 25 15:03:18.06: [13503]: RECV: reject TCF (zero run too short, min 1200)
mai 25 15:03:18.08: [13503]: --> [10:NO CARRIER]
mai 25 15:03:18.08: [13503]: DELAY 75 ms
mai 25 15:03:18.15: [13503]: <-- [9:AT+FTH=3\r]
mai 25 15:03:18.47: [13503]: --> [7:CONNECT]
mai 25 15:03:18.47: [13503]: <-- HDLC<3:FF C8 22>
mai 25 15:03:18.47: [13503]: <-- data [3]
mai 25 15:03:
18.47: [13503]: <-- data [2]
mai 25 15:03:19.79: [13503]: --> [2:OK]
mai 25 15:03:19.79: [13503]: TRAINING failed
mai 25 15:03:19.79: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:19.96: [13503]: --> [7:CONNECT]
mai 25 15:03:21.67: [13503]: --> HDLC<25:FF C0 C2 CC 0C 1C 04 9C 9C 4C 04 2C EC 04 04 04 04 04 04 04 04 04 04 07 9C>
mai 25 15:03:21.75: [13503]: --> [2:OK]
mai 25 15:03:21.75: [13503]: REMOTE TSI "74 299 803"
mai 25 15:03:21.75: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:21.77: [13503]: --> [7:CONNECT]
mai 25 15:03:22.05: [13503]: --> HDLC<11:FF C8 C1 00 70 15 01 01 00 0E 2A>
mai 25 15:03:22.08: [13503]: --> [2:OK]
mai 25 15:03:22.08: [13503]: REMOTE wants 7200 bit/s
mai 25 15:03:22.08: [13503]: REMOTE wants A4 page width (215 mm)
mai 25 15:03:22.08: [13503]: REMOTE wants unlimited page length
mai 25 15:03:22.08: [13503]: REMOTE wants 
3.85 line/mm
mai 25 15:03:22.08: [13503]: REMOTE wants 1-D MH
mai 25 15:03:22.08: [13503]: RECV training at v.29 7200 bit/s
mai 25 15:03:22.08: [13503]: <-- [10:AT+FRM=72\r]
mai 25 15:03:22.38: [13503]: --> [7:CONNECT]
mai 25 15:03:23.93: [13503]: RECV: TCF 1356 bytes, 86% non-zero, 1 zero-run
mai 25 15:03:23.93: [13503]: RECV: reject TCF (too many non-zero, max 10%)
mai 25 15:03:23.93: [13503]: RECV: reject TCF (zero run too short, min 900)
mai 25 15:03:23.96: [13503]: --> [10:NO CARRIER]
mai 25 15:03:23.96: [13503]: DELAY 75 ms
mai 25 15:03:24.03: [13503]: <-- [9:AT+FTH=3\r]
mai 25 15:03:24.35: [13503]: --> [7:CONNECT]
mai 25 15:03:
24.35: [13503]: <-- HDLC<3:FF C8 22>
mai 25 15:03:24.35: [13503]: <-- data [3]
mai 25 15:03:24.35: [13503]: <-- data [2]
mai 25 15:03:25.61: [13503]: --> [2:OK]
mai 25 15:03:25.61: [13503]: TRAINING failed
mai 25 15:03:25.61: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:25.79: [13503]: --> [7:CONNECT]
mai 25 15:03:27.49: [13503]: --> HDLC<25:FF C0 C2 CC 0C 1C 04 9C 9C 4C 04 2C EC 04 04 04 04 04 04 04 04 04 04 07 9C>
mai 25 15:03:27.58: [13503]: --> [2:OK]
mai 25 15:03:27.58: [13503]: REMOTE TSI "74 299 803"
mai 25 15:03:27.58: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:27.60: [13503]: --> [7:CONNECT]
mai 25 15:03:27.87: [13503]: --> HDLC<11:FF C8 C1 00 70 15 01 01 00 0E 2A>
mai 25 15:03:27.94: [13503]: --> [2:OK]
mai 25 15:03:27.94: [13503]: REMOTE wants 7200 bit/s
mai 25 15:03:27.94: [13503]: REMOTE wants A4 page width (215 mm)
mai 25 15:03:27.94: [13503]: REMOTE wants unlimited page length
mai 25 15:03:27.94: [13503]: REMOTE wants 3.85 line/mm
mai 25 15:03:27.94: [13503]: REMOTE wants 1-D MH
mai 25 15:03:27.94: [13503]: RECV training at 
v.29 7200 bit/s
mai 25 15:03:27.94: [13503]: <-- [10:AT+FRM=72\r]
mai 25 15:03:28.24: [13503]: --> [7:CONNECT]
mai 25 15:03:29.77: [13503]: RECV: TCF 1344 bytes, 72% non-zero, 1 zero-run
mai 25 15:03:29.77
: [13503]: RECV: reject TCF (too many non-zero, max 10%)
mai 25 15:03:29.77: [13503]: RECV: reject TCF (zero run too short, min 900)
mai 25 15:03:29.79: [13503]: --> [10:NO CARRIER]
mai 25 15:03:29.79: [13503]: DELAY 75 ms
mai 25 15:03:29.86: [13503]: <-- [9:AT+FTH=3\r]
mai 25 15:03:30.18: [13503]: --> [7:CONNECT]
mai 25 15:03:30.18: [13503]: <-- HDLC<3:FF C8 22>
mai 25 15:03:30.18: [13503]: <-- data [3]
mai 25 15:03:
30.18: [13503]: <-- data [2]
mai 25 15:03:31.45: [13503]: --> [2:OK]
mai 25 15:03:31.45: [13503]: TRAINING failed
mai 25 15:03:31.45: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:31.65: [13503]: --> [7:CONNECT]
mai 25 15:03:33.33: [13503]: --> HDLC<25:FF C0 C2 CC 0C 1C 04 9C 9C 4C 04 2C EC 04 04 04 04 04 04 04 04 04 04 07 9C>
mai 25 15:03:33.41: [13503]: --> [2:OK]
mai 25 15:03:33.41: [13503]: REMOTE TSI "74 299 803"
mai 25 15:03:33.41: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:33.43: [13503]: --> [7:CONNECT]
mai 25 15:03:33.71: [13503]: --> HDLC<11:FF C8 C1 00 50 15 01 01 00 06 9E>
mai 25 15:03:33.77: [13503]: --> [2:OK]
mai 25 15:03:33.77: [13503]: REMOTE wants 4800 bit/s
mai 25 15:03:33.77: [13503]: REMOTE wants A4 page width (215 mm)
mai 25 15:03:33.77: [13503]: REMOTE wants unlimited page length
mai 25 15:03:33.77: [13503]: REMOTE wants 
3.85 line/mm
mai 25 15:03:33.77: [13503]: REMOTE wants 1-D MH
mai 25 15:03:33.77: [13503]: RECV training at v.27ter 4800 bit/s
mai 25 15:03:33.77: [13503]: <-- [10:AT+FRM=48\r]
mai 25 15:03:38.27: [13503]: --> [0:]
mai 25 15:03:38.27: [13503]: MODEM <Empty line>
mai 25 15:03:38.27: [13503]: MODEM TIMEOUT: receiving TCF
mai 25 15:03:38.27: [13503]: <-- data [1]
mai 25 15:03:38.47: [13503]: MODEM TIMEOUT: reading line from modem
mai 25 15:03:38.47: [13503]: MODEM <Timeout>
mai 25 15:03:38.47: [13503]: DELAY 75 ms
mai 25 15:03:38.55: [13503]: <-- [9:AT+FTH=3\r]
mai 25 15:03:46.10: [13503]: --> [0:]
mai 25 15:03:46.10: [13503]: MODEM TIMEOUT: sending HDLC frame
mai 25 15:03:46.10: [13503]: TRAINING failed
mai 25 15:03:46.10: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:46.14: [13503]: --> [7:CONNECT]
mai 25 15:03:48.76: [13503]: --> HDLC<25:FF C0 C2 CC 0C 1C 04 9C 9C 4C 04 2C EC 04 04 04 04 04 04 04 04 04 04 07 9C>
mai 25 15:03:48.85: [13503]: --> [2:OK]
mai 25 15:03:48.85: [13503]: REMOTE TSI "74 299 803"
mai 25 15:03:48.85: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:03:48.87: [13503]: --> [7:CONNECT]
mai 25 15:03:49.14: [13503]: --> HDLC<11:FF C8 C1 00 50 15 01 01 00 06 9E>
mai 25 15:03:49.21: [13503]: --> [2:OK]
mai 25 15:03:49.21: [13503]: REMOTE wants 4800 bit/s
mai 25 15:03:49.21: [13503]: REMOTE wants A4 page width (215 mm)
mai 25 15:03:49.21: [13503]: REMOTE wants unlimited page length
mai 25 15:03:49.21: [13503]: REMOTE wants 3.85 line/mm
mai 25 15:03:49.21: [13503]: REMOTE wants 1-D MH
mai 25 15:03:49.21: [13503]: RECV training at 
v.27ter 4800 bit/s
mai 25 15:03:49.21: [13503]: <-- [10:AT+FRM=48\r]
mai 25 15:03:53.71: [13503]: --> [0:]
mai 25 15:03:53.71: [13503]: MODEM <Empty line>
mai 25 15:03:53.71: [13503]: MODEM TIMEOUT: receiving TCF
mai 25 15:03:53.71: [13503]: <-- data [1]
mai 25 15:03:53.91: [13503]: MODEM TIMEOUT: reading line from modem
mai 25 15:03:53.91: [13503]: MODEM <Timeout>
mai 25 15:03:53.91: [13503]: DELAY 75 ms
mai 25 15:03:53.98: [13503]: <-- [9:AT+FTH=3\r]
mai 25 15:04:01.53: [13503]: --> [0:]
mai 25 15:04:01.53: [13503]: MODEM TIMEOUT: sending HDLC frame
mai 25 15:04:01.53: [13503]: TRAINING failed
mai 25 15:04:
01.53: [13503]: <-- [9:AT+FRH=3\r]
mai 25 15:04:01.58: [13503]: --> [7:CONNECT]
mai 25 15:04:06.58: [13503]: MODEM TIMEOUT: receiving HDLC frame data
mai 25 15:04:06.58: [13503]: <-- data [1]
mai 25 15:04:
06.68: [13503]: --> [2:OK]
mai 25 15:04:06.68: [13503]: RECV FAX: Failure to train modems
mai 25 15:04:06.68: [13503]: RECV FAX: end
mai 25 15:04:06.68: [13503]: SESSION END
-------------------------------------

On 5/25/06, Lee Howard <faxguy@xxxxxxxxxxxxxxxx> wrote:

Fourat Zouari wrote:

> From the logs, the fax seems to be having erronous data (86% non-zero,
> 1 zero-run), i've tried to receive the same fax on a fax terminal,
> it's receiving and the quality is very clear and good.
>
> What should i do to avoid this ?


It may help to see the full log.  But you may want to try a different modem.

For some reason the data as sent from the sender is getting corrupted
somewhere between there and HylaFAX.  It could be audio distortion on
the phone lines or PBXes, or it could be a broken demodulator in the
modem itself.

Lee.