Re: [hylafax-users] Incomplete received fax with Comtrol RocketModem II

[Lee Howard <faxguy@howardsilvan.com>]

On 2003.07.31 08:12 Alberto Lirussi wrote:

> Jul 31 15:05:31.51: [ 3366]: HylaFAX (tm) Version 4.1.6
> Jul 31 15:05:31.51: [ 3366]: <-- [4:ATA\r]
> Jul 31 15:05:37.74: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:37.74: [ 3366]: ANSWER: FAX CONNECTION  DEVICE
> '/dev/ttyR1'
> Jul 31 15:05:37.74: [ 3366]: STATE CHANGE: ANSWERING -> RECEIVING
> Jul 31 15:05:37.74: [ 3366]: MODEM input buffering enabled
> Jul 31 15:05:37.74: [ 3366]: RECV FAX: begin
> Jul 31 15:05:37.74: [ 3366]: MODEM input buffering disabled
> Jul 31 15:05:37.74: [ 3366]: <-- HDLC<23:FF C0 02 86 2E 86 26 B6 F6 C2
> 04 04
> 04 04 04 04 04 04 04 04 04 04 04>
> Jul 31 15:05:37.74: [ 3366]: <-- data [23]
> Jul 31 15:05:37.74: [ 3366]: <-- data [2]
> Jul 31 15:05:39.43: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:39.43: [ 3366]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03
> C0>
> Jul 31 15:05:39.43: [ 3366]: <-- data [10]
> Jul 31 15:05:39.43: [ 3366]: <-- data [2]
> Jul 31 15:05:39.96: [ 3366]: --> [2:OK]
> Jul 31 15:05:39.96: [ 3366]: <-- [9:AT+FRH=3\r]
> Jul 31 15:05:43.06: [ 3366]: --> [0:]
> Jul 31 15:05:43.06: [ 3366]: MODEM <Empty line>
> Jul 31 15:05:43.06: [ 3366]: MODEM TIMEOUT: waiting for v.21 carrier
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> First error

Actually it's not an error so much as it is a notification that the 
transmitter isn't yet transmitting DCS as it should be, so we just 
retry.

> Jul 31 15:05:43.06: [ 3366]: <-- data [1]
> Jul 31 15:05:43.12: [ 3366]: --> [2:OK]
> Jul 31 15:05:43.12: [ 3366]: DELAY 1500 ms
> Jul 31 15:05:44.62: [ 3366]: <-- [9:AT+FTH=3\r]
> Jul 31 15:05:44.67: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:44.67: [ 3366]: <-- HDLC<23:FF C0 02 86 2E 86 26 B6 F6 C2
> 04 04
> 04 04 04 04 04 04 04 04 04 04 04>
> Jul 31 15:05:44.67: [ 3366]: <-- data [23]
> Jul 31 15:05:44.67: [ 3366]: <-- data [2]
> Jul 31 15:05:46.46: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:46.46: [ 3366]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03
> C0>
> Jul 31 15:05:46.46: [ 3366]: <-- data [10]
> Jul 31 15:05:46.46: [ 3366]: <-- data [2]
> Jul 31 15:05:46.99: [ 3366]: --> [2:OK]
> Jul 31 15:05:46.99: [ 3366]: <-- [9:AT+FRH=3\r]
> Jul 31 15:05:50.09: [ 3366]: --> [0:]
> Jul 31 15:05:50.09: [ 3366]: MODEM <Empty line>
> Jul 31 15:05:50.09: [ 3366]: MODEM TIMEOUT: waiting for v.21 carrier
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> Same error

Same thing... the remote isn't yet transmitting DCS for whatever reason 
- usually this is just a timing issue and eventually works out.

> Jul 31 15:05:50.09: [ 3366]: <-- data [1]
> Jul 31 15:05:50.15: [ 3366]: --> [2:OK]
> Jul 31 15:05:50.15: [ 3366]: DELAY 1500 ms
> Jul 31 15:05:51.65: [ 3366]: <-- [9:AT+FTH=3\r]
> Jul 31 15:05:51.70: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:51.70: [ 3366]: <-- HDLC<23:FF C0 02 86 2E 86 26 B6 F6 C2
> 04 04
> 04 04 04 04 04 04 04 04 04 04 04>
> Jul 31 15:05:51.70: [ 3366]: <-- data [23]
> Jul 31 15:05:51.70: [ 3366]: <-- data [2]
> Jul 31 15:05:53.49: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:53.49: [ 3366]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03
> C0>
> Jul 31 15:05:53.49: [ 3366]: <-- data [10]
> Jul 31 15:05:53.49: [ 3366]: <-- data [2]
> Jul 31 15:05:54.02: [ 3366]: --> [2:OK]
> Jul 31 15:05:54.02: [ 3366]: <-- [9:AT+FRH=3\r]
> Jul 31 15:05:54.46: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:55.98: [ 3366]: --> HDLC<25:FF C0 C2 4C 9C 9C EC 0C CC 4C
> 4C 2C
> 0C 04 04 04 04 04 04 04 04 04 04 62 85>
> Jul 31 15:05:55.99: [ 3366]: --> [2:OK]
> Jul 31 15:05:55.99: [ 3366]: REMOTE TSI "0422XXXXXXX"
> Jul 31 15:05:55.99: [ 3366]: <-- [9:AT+FRH=3\r]
> Jul 31 15:05:56.01: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:56.41: [ 3366]: --> HDLC<11:FF C8 C1 00 45 1F 01 01 00 49
> 38>
> Jul 31 15:05:56.42: [ 3366]: --> [2:OK]

You see.  Finally things got worked out.

> Jul 31 15:05:56.42: [ 3366]: REMOTE wants 14400 bit/s
> Jul 31 15:05:56.42: [ 3366]: REMOTE wants page width 1728 pixels in
> 215 mm
> Jul 31 15:05:56.42: [ 3366]: REMOTE wants unlimited page length
> Jul 31 15:05:56.42: [ 3366]: REMOTE wants 3.85 line/mm
> Jul 31 15:05:56.42: [ 3366]: REMOTE wants 2-D MR
> Jul 31 15:05:56.42: [ 3366]: RECV training at v.17 14400 bit/s
> Jul 31 15:05:56.42: [ 3366]: <-- [11:AT+FRM=145\r]
> Jul 31 15:05:58.12: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:59.74: [ 3366]: RECV: TCF 2885 bytes, 0% non-zero, 2863
> zero-run
> Jul 31 15:05:59.75: [ 3366]: --> [10:NO CARRIER]
> Jul 31 15:05:59.75: [ 3366]: DELAY 75 ms
> Jul 31 15:05:59.83: [ 3366]: TRAINING succeeded
> Jul 31 15:05:59.83: [ 3366]: <-- [9:AT+FTH=3\r]
> Jul 31 15:05:59.88: [ 3366]: --> [7:CONNECT]
> Jul 31 15:05:59.88: [ 3366]: <-- HDLC<3:FF C8 21>
> Jul 31 15:05:59.88: [ 3366]: <-- data [3]
> Jul 31 15:05:59.88: [ 3366]: <-- data [2]
> Jul 31 15:06:01.20: [ 3366]: --> [2:OK]
> Jul 31 15:06:01.20: [ 3366]: MODEM input buffering enabled
> Jul 31 15:06:01.20: [ 3366]: <-- [11:AT+FRM=146\r]
> Jul 31 15:06:02.09: [ 3366]: --> [7:CONNECT]
> Jul 31 15:06:02.09: [ 3366]: RECV: begin page
> Jul 31 15:07:06.94: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1121,
> got 0,
> expected 1728
> Jul 31 15:07:06.94: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1122,
> got 0,
> expected 1728
> Jul 31 15:07:06.94: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1123,
> got 0,
> expected 1728
> Jul 31 15:07:07.09: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1124,
> got 0,
> expected 1728
> Jul 31 15:07:07.09: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1125,
> got 0,
> expected 1728
> Jul 31 15:07:07.09: [ 3366]: RECV/CQ: Adjusting for RTC found at row
> 1120
> Jul 31 15:07:07.09: [ 3366]: RECV: 1120 total lines, 0 bad lines, 0
> consecutive bad lines
> Jul 31 15:07:07.09: [ 3366]: RECV: end page
> Jul 31 15:07:07.09: [ 3366]: --> [10:NO CARRIER]
> Jul 31 15:07:07.09: [ 3366]: MODEM input buffering disabled
> Jul 31 15:07:07.09: [ 3366]: <-- [9:AT+FRH=3\r]
> Jul 31 15:07:07.41: [ 3366]: --> [7:CONNECT]
> Jul 31 15:07:08.32: [ 3366]: --> HDLC<5:FF C8 F2 AC A0>
> Jul 31 15:07:08.33: [ 3366]: --> [2:OK]
> Jul 31 15:07:08.33: [ 3366]: RECV recv MPS (more pages, same document)
> Jul 31 15:07:08.33: [ 3366]: <-- [9:AT+FRS=7\r]
> Jul 31 15:07:08.45: [ 3366]: --> [2:OK]
> Jul 31 15:07:08.45: [ 3366]: <-- [9:AT+FTH=3\r]
> Jul 31 15:07:08.50: [ 3366]: --> [7:CONNECT]
> Jul 31 15:07:08.50: [ 3366]: RECV send MCF (message confirmation)
> Jul 31 15:07:08.50: [ 3366]: RECV FAX (00000564): from 0422307992,
> page 1 in
> 1:09, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
> Jul 31 15:07:08.50: [ 3366]: <-- HDLC<3:FF C8 31>
> Jul 31 15:07:08.50: [ 3366]: <-- data [3]
> Jul 31 15:07:08.50: [ 3366]: <-- data [2]
> Jul 31 15:07:09.82: [ 3366]: --> [2:OK]
> Jul 31 15:07:09.82: [ 3366]: MODEM input buffering enabled
> Jul 31 15:07:09.82: [ 3366]: <-- [11:AT+FRM=146\r]
> Jul 31 15:07:10.71: [ 3366]: --> [7:CONNECT]
> Jul 31 15:07:10.71: [ 3366]: RECV: begin page
> Jul 31 15:07:59.04: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1120,
> got 0,
> expected 1728
> Jul 31 15:07:59.04: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1121,
> got 0,
> expected 1728
> Jul 31 15:07:59.04: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1122,
> got 0,
> expected 1728
> Jul 31 15:07:59.04: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1123,
> got 0,
> expected 1728
> Jul 31 15:07:59.04: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1124,
> got 0,
> expected 1728
> Jul 31 15:07:59.04: [ 3366]: RECV/CQ: Bad 1D pixel count, row 1125,
> got
> 2881, expected 1728
> Jul 31 15:07:59.04: [ 3366]: RECV/CQ: Adjusting for trailing noise (6
> run)
> Jul 31 15:07:59.04: [ 3366]: RECV: 1120 total lines, 0 bad lines, 0
> consecutive bad lines
> Jul 31 15:07:59.04: [ 3366]: RECV: end page
> Jul 31 15:07:59.04: [ 3366]: --> [10:NO CARRIER]
> Jul 31 15:07:59.04: [ 3366]: MODEM input buffering disabled
> Jul 31 15:07:59.04: [ 3366]: <-- [9:AT+FRH=3\r]
> Jul 31 15:07:59.39: [ 3366]: --> [7:CONNECT]
> Jul 31 15:08:00.28: [ 3366]: --> HDLC<5:FF C8 F2 AC A0>
> Jul 31 15:08:00.28: [ 3366]: --> [2:OK]
> Jul 31 15:08:00.28: [ 3366]: RECV recv MPS (more pages, same document)
> Jul 31 15:08:00.28: [ 3366]: <-- [9:AT+FRS=7\r]
> Jul 31 15:08:00.40: [ 3366]: --> [2:OK]
> Jul 31 15:08:00.40: [ 3366]: <-- [9:AT+FTH=3\r]
> Jul 31 15:08:00.45: [ 3366]: --> [7:CONNECT]
> Jul 31 15:08:00.45: [ 3366]: RECV send MCF (message confirmation)
> Jul 31 15:08:00.45: [ 3366]: RECV FAX (00000564): from 0422307992,
> page 2 in
> 0:52, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
> Jul 31 15:08:00.45: [ 3366]: <-- HDLC<3:FF C8 31>
> Jul 31 15:08:00.45: [ 3366]: <-- data [3]
> Jul 31 15:08:00.45: [ 3366]: <-- data [2]
> Jul 31 15:08:01.76: [ 3366]: --> [2:OK]
> Jul 31 15:08:01.76: [ 3366]: MODEM input buffering enabled
> Jul 31 15:08:01.76: [ 3366]: <-- [11:AT+FRM=146\r]
> Jul 31 15:08:02.66: [ 3366]: --> [7:CONNECT]
> Jul 31 15:08:02.66: [ 3366]: RECV: begin page
> Jul 31 15:08:09.77: [ 3366]: RECV/CQ: Bad 1D pixel count, row 212, got
> 2281,
> expected 1728
> Jul 31 15:08:10.76: [ 3366]: RECV/CQ: Invalid 2D code word, row 213, x
> 188
> Jul 31 15:08:10.76: [ 3366]: RECV/CQ: Bad 2D pixel count, row 213, got
> 188,
> expected 1728
> Jul 31 15:08:11.05: [ 3366]: RECV/CQ: Bad 1D pixel count, row 214, got
> 3199,
> expected 1728
> Jul 31 15:08:11.51: [ 3366]: RECV/CQ: Invalid WhiteTable code word,
> row 216,
> x 348
> Jul 31 15:08:11.51: [ 3366]: RECV/CQ: Bad 1D pixel count, row 216, got
> 348,
> expected 1728
> Jul 31 15:08:11.73: [ 3366]: RECV/CQ: Bad 2D pixel count, row 217, got
> 1729,
> expected 1728
> Jul 31 15:08:11.80: [ 3366]: RECV/CQ: Bad 2D pixel count, row 218, got
> 1731,
> expected 1728
> Jul 31 15:08:12.49: [ 3366]: RECV/CQ: Bad 1D pixel count, row 223, got
> 3791,
> expected 1728
> Jul 31 15:08:13.09: [ 3366]: RECV/CQ: Adjusting for trailing noise (1
> run)
> Jul 31 15:08:13.09: [ 3366]: RECV: 223 total lines, 6 bad lines, 3
> consecutive bad lines
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> ^ only 223 lines instead of 1728

How do you know it was supposed to be 1728?  1728 pixels is the width.  
Since we accept unlimited length pages, it could possibly be 223 lines 
long.  Given the number of errors, it's not likely, though, and we'll 
send RTN and rewrite the page.

> Jul 31 15:08:13.09: [ 3366]: RECV: end page
> Jul 31 15:08:13.09: [ 3366]: --> [10:NO CARRIER]
> Jul 31 15:08:13.09: [ 3366]: MODEM input buffering disabled
> Jul 31 15:08:13.09: [ 3366]: <-- [9:AT+FRH=3\r]
> Jul 31 15:08:53.09: [ 3366]: --> [0:]
> Jul 31 15:08:53.09: [ 3366]: MODEM <Empty line>
> Jul 31 15:08:53.09: [ 3366]: MODEM TIMEOUT: waiting for v.21 carrier
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> ^^^^^: Second error

This is a terminal problem.  We didn't get the post-page message.  So 
the page gets discarded.

> Jul 31 15:08:53.09: [ 3366]: <-- data [1]
> Jul 31 15:08:53.14: [ 3366]: --> [2:OK]
> Jul 31 15:08:53.14: [ 3366]: RECV FAX (00000564): recvq/fax00462.tif
> from
> 0422307992, route to <unspecified>, 2 pages in 3:16
> Jul 31 15:08:53.14: [ 3366]: RECV FAX: T.30 T2 timeout, expected page
> not
> received
> Jul 31 15:08:53.14: [ 3366]: <-- [9:AT+FTH=3\r]
> Jul 31 15:08:53.19: [ 3366]: --> [7:CONNECT]
> Jul 31 15:08:53.19: [ 3366]: <-- HDLC<3:FF C8 5F>
> Jul 31 15:08:53.19: [ 3366]: <-- data [3]
> Jul 31 15:08:53.19: [ 3366]: <-- data [2]
> Jul 31 15:08:54.50: [ 3366]: --> [2:OK]
> Jul 31 15:08:54.50: [ 3366]: MODEM input buffering enabled
> Jul 31 15:08:54.50: [ 3366]: RECV FAX (00000564): session with
> 0422307992
> terminated abnormally: T.30 T2 timeout, expected page not received
> Jul 31 15:08:54.50: [ 3366]: RECV FAX: bin/faxrcvd
> "recvq/fax00462.tif"
> "ttyR1" "00000564" "T.30 T2 timeout, expected page not received" "" ""
> Jul 31 15:08:54.94: [ 3366]: RECV FAX: end
> Jul 31 15:08:54.94: [ 3366]: SESSION END
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> expected
> page not received

Exactly.  We expected three pages but didn't get the third.

> 
> 
> 
> 
> SECOND EXAMPLE
> 
> Jul 30 14:37:45.60: [ 1264]: --> [10:NO CARRIER]
> Jul 30 14:37:45.60: [ 1264]: <-- [9:AT+FRH=3\r]
> Jul 30 14:37:45.96: [ 1264]: --> [7:CONNECT]
> Jul 30 14:37:46.73: [ 1264]: --> [2:OK]
> Jul 30 14:37:46.73: [ 1264]: RECV recv MPS (more pages, same document)
> Jul 30 14:37:46.73: [ 1264]: <-- [9:AT+FRS=7\r]
> Jul 30 14:37:46.89: [ 1264]: --> [2:OK]
> Jul 30 14:37:46.89: [ 1264]: <-- [9:AT+FTH=3\r]
> Jul 30 14:37:46.94: [ 1264]: --> [7:CONNECT]
> Jul 30 14:37:46.94: [ 1264]: RECV send MCF (message confirmation)
> Jul 30 14:37:46.94: [ 1264]: RECV FAX (00000478): from +39 0125649786,
> page
> 2 in 0:20, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
> Jul 30 14:37:46.94: [ 1264]: <-- data [3]
> Jul 30 14:37:46.94: [ 1264]: <-- data [2]
> Jul 30 14:37:48.26: [ 1264]: --> [2:OK]
> Jul 30 14:37:48.26: [ 1264]: <-- [11:AT+FRM=146\r]
> Jul 30 14:37:49.18: [ 1264]: --> [7:CONNECT]
> Jul 30 14:37:49.18: [ 1264]: RECV: begin page
> Jul 30 14:37:51.08: [ 1264]: RECV: 144 total lines, 0 bad lines, 0
> consecutive bad lines
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> ^^^^ 144 lines

Again, not an entirely impossible scenario.

> 
> Jul 30 14:37:51.08: [ 1264]: RECV: end page
> Jul 30 14:37:51.08: [ 1264]: --> [10:NO CARRIER]
> Jul 30 14:37:51.08: [ 1264]: <-- [9:AT+FRH=3\r]
> Jul 30 14:38:10.99: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:11.94: [ 1264]: --> [2:OK]
> Jul 30 14:38:11.94: [ 1264]: RECV recv MPS (more pages, same document)
> Jul 30 14:38:11.94: [ 1264]: <-- [9:AT+FRS=7\r]
> Jul 30 14:38:12.07: [ 1264]: --> [2:OK]
> Jul 30 14:38:12.07: [ 1264]: <-- [9:AT+FTH=3\r]
> Jul 30 14:38:12.12: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:12.12: [ 1264]: RECV send MCF (message confirmation)
> Jul 30 14:38:12.12: [ 1264]: RECV FAX (00000478): from +39 0125649786,
> page
> 3 in 0:26, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
> Jul 30 14:38:12.12: [ 1264]: <-- data [3]
> Jul 30 14:38:12.12: [ 1264]: <-- data [2]
> Jul 30 14:38:13.44: [ 1264]: --> [2:OK]
> Jul 30 14:38:13.44: [ 1264]: <-- [11:AT+FRM=146\r]
> Jul 30 14:38:14.35: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:14.35: [ 1264]: RECV: begin page
> Jul 30 14:38:17.64: [ 1264]: RECV: 342 total lines, 0 bad lines, 0
> consecutive bad lines
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> 342 lines

And again.

> Jul 30 14:38:17.64: [ 1264]: RECV: end page
> Jul 30 14:38:17.64: [ 1264]: --> [10:NO CARRIER]
> Jul 30 14:38:17.64: [ 1264]: <-- [9:AT+FRH=3\r]
> Jul 30 14:38:27.81: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:28.24: [ 1264]: --> [5:ERROR]
> Jul 30 14:38:28.24: [ 1264]: MODEM Command error
> Jul 30 14:38:28.24: [ 1264]: FCS error
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ error

This means that we're not in-sync with the remote and/or are hearing 
too much static.

> Jul 30 14:38:28.24: [ 1264]: <-- [9:AT+FRH=3\r]
> Jul 30 14:38:28.58: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:28.78: [ 1264]: --> [2:OK]
> Jul 30 14:38:28.78: [ 1264]: RECV recv MPS (more pages, same document)
> Jul 30 14:38:28.78: [ 1264]: <-- [9:AT+FRS=7\r]
> Jul 30 14:38:28.91: [ 1264]: --> [2:OK]
> Jul 30 14:38:28.91: [ 1264]: <-- [9:AT+FTH=3\r]
> Jul 30 14:38:28.96: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:28.96: [ 1264]: RECV send MCF (message confirmation)
> Jul 30 14:38:28.96: [ 1264]: RECV FAX (00000478): from +39 0125649786,
> page
> 4 in 0:16, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
> Jul 30 14:38:28.96: [ 1264]: <-- data [3]
> Jul 30 14:38:28.96: [ 1264]: <-- data [2]
> Jul 30 14:38:30.28: [ 1264]: --> [2:OK]
> Jul 30 14:38:30.28: [ 1264]: <-- [11:AT+FRM=146\r]
> Jul 30 14:38:31.20: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:31.20: [ 1264]: RECV: begin page
> Jul 30 14:38:33.52: [ 1264]: RECV: 236 total lines, 0 bad lines, 0
> consecutive bad lines
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> 236 lines

What can I say...?

> Jul 30 14:38:33.52: [ 1264]: RECV: end page
> Jul 30 14:38:33.52: [ 1264]: --> [10:NO CARRIER]
> Jul 30 14:38:33.52: [ 1264]: <-- [9:AT+FRH=3\r]
> Jul 30 14:38:38.15: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:38.83: [ 1264]: --> [5:ERROR]
> Jul 30 14:38:38.83: [ 1264]: MODEM Command error
> Jul 30 14:38:38.83: [ 1264]: FCS error
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> error

Again...

> Jul 30 14:38:38.83: [ 1264]: <-- [9:AT+FRH=3\r]
> Jul 30 14:38:42.45: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:43.40: [ 1264]: --> [2:OK]
> Jul 30 14:38:43.40: [ 1264]: RECV recv MPS (more pages, same document)
> Jul 30 14:38:43.40: [ 1264]: <-- [9:AT+FRS=7\r]
> Jul 30 14:38:43.53: [ 1264]: --> [2:OK]
> Jul 30 14:38:43.53: [ 1264]: <-- [9:AT+FTH=3\r]
> Jul 30 14:38:43.58: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:43.58: [ 1264]: RECV send MCF (message confirmation)
> Jul 30 14:38:43.58: [ 1264]: RECV FAX (00000478): from +39 0125649786,
> page
> 5 in 0:15, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
> Jul 30 14:38:43.58: [ 1264]: <-- data [3]
> Jul 30 14:38:43.58: [ 1264]: <-- data [2]
> Jul 30 14:38:44.89: [ 1264]: --> [2:OK]
> Jul 30 14:38:44.89: [ 1264]: <-- [11:AT+FRM=146\r]
> Jul 30 14:38:45.81: [ 1264]: --> [7:CONNECT]
> Jul 30 14:38:45.81: [ 1264]: RECV: begin page
> Jul 30 14:38:49.92: [ 1264]: RECV: 355 total lines, 0 bad lines, 0
> consecutive bad lines
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> ^^^^^ 355 lines
> 
> Jul 30 14:38:49.92: [ 1264]: RECV: end page
> Jul 30 14:38:49.92: [ 1264]: --> [10:NO CARRIER]
> Jul 30 14:38:49.92: [ 1264]: <-- [9:AT+FRH=3\r]
> Jul 30 14:39:00.04: [ 1264]: --> [7:CONNECT]
> Jul 30 14:39:00.99: [ 1264]: --> [2:OK]
> Jul 30 14:39:00.99: [ 1264]: RECV recv MPS (more pages, same document)
> Jul 30 14:39:00.99: [ 1264]: <-- [9:AT+FRS=7\r]
> Jul 30 14:39:01.11: [ 1264]: --> [2:OK]
> Jul 30 14:39:01.11: [ 1264]: <-- [9:AT+FTH=3\r]
> Jul 30 14:39:01.16: [ 1264]: --> [7:CONNECT]
> Jul 30 14:39:01.16: [ 1264]: RECV send MCF (message confirmation)
> Jul 30 14:39:01.16: [ 1264]: RECV FAX (00000478): from +39 0125649786,
> page
> 6 in 0:18, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
> Jul 30 14:39:01.16: [ 1264]: <-- data [3]
> Jul 30 14:39:01.16: [ 1264]: <-- data [2]
> Jul 30 14:39:02.47: [ 1264]: --> [2:OK]
> Jul 30 14:39:02.47: [ 1264]: <-- [11:AT+FRM=146\r]
> Jul 30 14:39:03.39: [ 1264]: --> [7:CONNECT]
> Jul 30 14:39:03.39: [ 1264]: RECV: begin page
> Jul 30 14:39:16.07: [ 1264]: RECV: 1127 total lines, 0 bad lines, 0
> consecutive bad lines
> ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
> ^^^ 1127 OK!
> 
> 
> ____________________ HylaFAX(tm) Users Mailing List
> _______________________
>   To subscribe/unsubscribe, click 
> http://lists.hylafax.org/cgi-bin/lsg2.cgi
>  On UNIX: mail -s unsubscribe hylafax-users-request@hylafax.org <
> /dev/null
>   *To learn about commercial HylaFAX(tm) support, mail
> sales@hylafax.org.*
> 

____________________ HylaFAX(tm) Users Mailing List _______________________
  To subscribe/unsubscribe, click http://lists.hylafax.org/cgi-bin/lsg2.cgi
 On UNIX: mail -s unsubscribe hylafax-users-request@hylafax.org < /dev/null
  *To learn about commercial HylaFAX(tm) support, mail sales@hylafax.org.*