[hylafax-users] Problem with one US Robotics modem : keeping unconfirmed page, "No carrier", "FCS error"...

["Sylvain MACHEFERT" <SYLVAIN.MACHEFERT@xxxxxxxxx>]

Hi!

 

I've installed 10 modem and hylafax server in various offices. There are all U.S. Robotics, the same config, RedHat Linux... Hylafax 4.1.8

One of them get tons of error, about 50% of the received faxes !

 

The TIFF images are often truncated.

 

I want to know

- if it's a problem on my phone line (my own tests sending from my fax to this office, are all OK)

- or on the modem?

- is there a way to correct this ?

 

See the first 2 logs below.

Log 1 is about FCS error, and log 2 is a huge list of No carrier.

 

-----------

 

Another fax modem has less errors, but customers allways re-send their faxes because they think it's not arrived complete, but it's complete (not truncated tiff image).

The line Oct 13 10:59:55.47: [ 1986]: --> [5:ÿ?] is very strange, does it speak chinese ? :-)

See log number 3 below.

 

Thanks in advance for your precious help!

 

 

Sylvain Machefert

 

 

LOG 1 - FCS error

    T.30 T2 timeout, expected page not received

 

    ---- Transcript of session follows ----

 

Oct 13 11:15:07.26: [ 1985]: SESSION BEGIN 000000062 330477818119
Oct 13 11:15:07.26: [ 1985]: HylaFAX (tm) Version 4.1.8
Oct 13 11:15:07.26: [ 1985]: <-- [13:AT+FCLASS=1A\r]
Oct 13 11:15:12.55: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:12.55: [ 1985]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Oct 13 11:15:12.55: [ 1985]: RECV FAX: begin
Oct 13 11:15:12.58: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:14.53: [ 1985]: --> [2:OK]
Oct 13 11:15:14.53: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:17.63: [ 1985]: --> [0:]
Oct 13 11:15:17.63: [ 1985]: MODEM <Empty line>
Oct 13 11:15:17.64: [ 1985]: --> [2:OK]
Oct 13 11:15:17.64: [ 1985]: DELAY 1500 ms
Oct 13 11:15:19.14: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:15:19.18: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:19.21: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:21.26: [ 1985]: --> [2:OK]
Oct 13 11:15:21.26: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:21.89: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:23.15: [ 1985]: --> [5:ERROR]
Oct 13 11:15:23.15: [ 1985]: MODEM Command error
Oct 13 11:15:23.15: [ 1985]: FCS error
Oct 13 11:15:23.15: [ 1985]: DELAY 1500 ms
Oct 13 11:15:24.65: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:15:24.85: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:24.88: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:26.93: [ 1985]: --> [2:OK]
Oct 13 11:15:26.93: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:29.89: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:31.54: [ 1985]: --> [2:OK]
Oct 13 11:15:31.54: [ 1985]: REMOTE TSI "0477466252"
Oct 13 11:15:31.54: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:31.56: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:31.83: [ 1985]: --> [2:OK]
Oct 13 11:15:31.83: [ 1985]: REMOTE wants 14400 bit/s
Oct 13 11:15:31.83: [ 1985]: REMOTE wants page width 1728 pixels in 215 mm
Oct 13 11:15:31.83: [ 1985]: REMOTE wants A4 page length (297 mm)
Oct 13 11:15:31.83: [ 1985]: REMOTE wants 3.85 line/mm
Oct 13 11:15:31.83: [ 1985]: REMOTE wants 1-D MR
Oct 13 11:15:31.83: [ 1985]: RECV training at v.17 14400 bit/s
Oct 13 11:15:31.83: [ 1985]: <-- [11:AT+FRM=145\r]
Oct 13 11:15:33.57: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:34.73: [ 1985]: RECV: TCF 2093 bytes, 2% non-zero, 1260 zero-run
Oct 13 11:15:34.73: [ 1985]: RECV: reject TCF (zero run too short, min 1800)
Oct 13 11:15:34.73: [ 1985]: --> [10:NO CARRIER]
Oct 13 11:15:34.73: [ 1985]: DELAY 75 ms
Oct 13 11:15:34.81: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:15:35.01: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:36.19: [ 1985]: --> [2:OK]
Oct 13 11:15:36.19: [ 1985]: TRAINING failed
Oct 13 11:15:36.19: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:36.65: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:38.06: [ 1985]: --> [2:OK]
Oct 13 11:15:38.06: [ 1985]: REMOTE TSI "0477466252"
Oct 13 11:15:38.06: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:38.08: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:38.36: [ 1985]: --> [2:OK]
Oct 13 11:15:38.36: [ 1985]: REMOTE wants 12000 bit/s
Oct 13 11:15:38.36: [ 1985]: REMOTE wants page width 1728 pixels in 215 mm
Oct 13 11:15:38.36: [ 1985]: REMOTE wants A4 page length (297 mm)
Oct 13 11:15:38.36: [ 1985]: REMOTE wants 3.85 line/mm
Oct 13 11:15:38.36: [ 1985]: REMOTE wants 1-D MR
Oct 13 11:15:38.36: [ 1985]: RECV training at v.17 12000 bit/s
Oct 13 11:15:38.36: [ 1985]: <-- [11:AT+FRM=121\r]
Oct 13 11:15:40.08: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:41.64: [ 1985]: RECV: TCF 2343 bytes, 4% non-zero, 1170 zero-run
Oct 13 11:15:41.64: [ 1985]: RECV: reject TCF (zero run too short, min 1500)
Oct 13 11:15:41.65: [ 1985]: --> [10:NO CARRIER]
Oct 13 11:15:41.65: [ 1985]: DELAY 75 ms
Oct 13 11:15:41.73: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:15:41.93: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:43.11: [ 1985]: --> [2:OK]
Oct 13 11:15:43.11: [ 1985]: TRAINING failed
Oct 13 11:15:43.11: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:43.49: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:44.97: [ 1985]: --> [2:OK]
Oct 13 11:15:44.97: [ 1985]: REMOTE TSI "0477466252"
Oct 13 11:15:44.97: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:44.99: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:45.26: [ 1985]: --> [2:OK]
Oct 13 11:15:45.26: [ 1985]: REMOTE wants 9600 bit/s
Oct 13 11:15:45.26: [ 1985]: REMOTE wants page width 1728 pixels in 215 mm
Oct 13 11:15:45.26: [ 1985]: REMOTE wants A4 page length (297 mm)
Oct 13 11:15:45.26: [ 1985]: REMOTE wants 3.85 line/mm
Oct 13 11:15:45.26: [ 1985]: REMOTE wants 1-D MR
Oct 13 11:15:45.26: [ 1985]: RECV training at v.17 9600 bit/s
Oct 13 11:15:45.26: [ 1985]: <-- [10:AT+FRM=97\r]
Oct 13 11:15:46.99: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:48.55: [ 1985]: RECV: TCF 1875 bytes, 4% non-zero, 859 zero-run
Oct 13 11:15:48.55: [ 1985]: RECV: reject TCF (zero run too short, min 1200)
Oct 13 11:15:48.55: [ 1985]: --> [10:NO CARRIER]
Oct 13 11:15:48.55: [ 1985]: DELAY 75 ms
Oct 13 11:15:48.63: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:15:48.83: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:50.01: [ 1985]: --> [2:OK]
Oct 13 11:15:50.01: [ 1985]: TRAINING failed
Oct 13 11:15:50.01: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:50.25: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:51.86: [ 1985]: --> [2:OK]
Oct 13 11:15:51.86: [ 1985]: REMOTE TSI "0477466252"
Oct 13 11:15:51.86: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:15:51.88: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:52.18: [ 1985]: --> [2:OK]
Oct 13 11:15:52.18: [ 1985]: REMOTE wants 2400 bit/s
Oct 13 11:15:52.18: [ 1985]: REMOTE wants page width 1728 pixels in 215 mm
Oct 13 11:15:52.18: [ 1985]: REMOTE wants A4 page length (297 mm)
Oct 13 11:15:52.18: [ 1985]: REMOTE wants 3.85 line/mm
Oct 13 11:15:52.18: [ 1985]: REMOTE wants 1-D MR
Oct 13 11:15:52.18: [ 1985]: RECV training at v.17 7200 bit/s
Oct 13 11:15:52.18: [ 1985]: <-- [10:AT+FRM=73\r]
Oct 13 11:15:53.89: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:55.45: [ 1985]: RECV: TCF 1406 bytes, 4% non-zero, 648 zero-run
Oct 13 11:15:55.46: [ 1985]: --> [10:NO CARRIER]
Oct 13 11:15:55.46: [ 1985]: DELAY 75 ms
Oct 13 11:15:55.54: [ 1985]: TRAINING succeeded
Oct 13 11:15:55.54: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:15:55.74: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:56.92: [ 1985]: --> [2:OK]
Oct 13 11:15:56.92: [ 1985]: <-- [10:AT+FRM=74\r]
Oct 13 11:15:59.89: [ 1985]: --> [7:CONNECT]
Oct 13 11:15:59.89: [ 1985]: RECV: begin page
Oct 13 11:16:00.88: [ 1985]: RECV: 0 total lines, 0 bad lines, 0 consecutive bad lines
Oct 13 11:16:00.88: [ 1985]: RECV: end page
Oct 13 11:16:00.88: [ 1985]: --> [10:NO CARRIER]
Oct 13 11:16:00.88: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:16:05.89: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:07.39: [ 1985]: --> [2:OK]
Oct 13 11:16:07.39: [ 1985]: REMOTE TSI "0477466252"
Oct 13 11:16:07.39: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:16:07.41: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:07.68: [ 1985]: --> [2:OK]
Oct 13 11:16:07.68: [ 1985]: REMOTE wants 2400 bit/s
Oct 13 11:16:07.68: [ 1985]: REMOTE wants page width 1728 pixels in 215 mm
Oct 13 11:16:07.68: [ 1985]: REMOTE wants A4 page length (297 mm)
Oct 13 11:16:07.68: [ 1985]: REMOTE wants 3.85 line/mm
Oct 13 11:16:07.68: [ 1985]: REMOTE wants 1-D MR
Oct 13 11:16:07.68: [ 1985]: RECV training at v.17 7200 bit/s
Oct 13 11:16:07.68: [ 1985]: <-- [10:AT+FRM=73\r]
Oct 13 11:16:09.40: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:10.96: [ 1985]: RECV: TCF 1406 bytes, 4% non-zero, 629 zero-run
Oct 13 11:16:10.97: [ 1985]: --> [10:NO CARRIER]
Oct 13 11:16:10.97: [ 1985]: DELAY 75 ms
Oct 13 11:16:11.05: [ 1985]: TRAINING succeeded
Oct 13 11:16:11.05: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:16:11.25: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:12.43: [ 1985]: --> [2:OK]
Oct 13 11:16:12.43: [ 1985]: <-- [10:AT+FRM=74\r]
Oct 13 11:16:13.51: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:13.51: [ 1985]: RECV: begin page
Oct 13 11:16:15.50: [ 1985]: RECV: 60 total lines, 2 bad lines, 1 consecutive bad lines
Oct 13 11:16:15.50: [ 1985]: RECV: end page
Oct 13 11:16:15.50: [ 1985]: --> [10:NO CARRIER]
Oct 13 11:16:15.50: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:16:19.16: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:21.90: [ 1985]: --> [5:ERROR]
Oct 13 11:16:21.90: [ 1985]: MODEM Command error
Oct 13 11:16:21.90: [ 1985]: FCS error
Oct 13 11:16:21.90: [ 1985]: <-- [9:AT+FRH=3\r]
Oct 13 11:16:21.92: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:26.93: [ 1985]: --> [2:OK]
Oct 13 11:16:26.93: [ 1985]: RECV keeping unconfirmed page
Oct 13 11:16:26.93: [ 1985]: RECV FAX (000000062): from 0477466252, page 1 in 0:31, A4, 3.85 line/mm, 1-D MR, 2400 bit/s
Oct 13 11:16:26.93: [ 1985]: RECV FAX (000000062): recvq/fax000000048.tif from 0477466252, route to <unspecified>, 1 pages in 1:14
Oct 13 11:16:26.93: [ 1985]: RECV FAX: T.30 T2 timeout, expected page not received
Oct 13 11:16:26.93: [ 1985]: <-- [9:AT+FTH=3\r]
Oct 13 11:16:26.97: [ 1985]: --> [7:CONNECT]
Oct 13 11:16:28.15: [ 1985]: --> [2:OK]
Oct 13 11:16:28.15: [ 1985]: RECV FAX (000000062): session with 0477466252 terminated abnormally: T.30 T2 timeout, expected page not received
Oct 13 11:16:28.15: [ 1985]: RECV FAX: bin/faxrcvd "recvq/fax000000048.tif" "ttyS0" "000000062" "T.30 T2 timeout, expected page not received" "" ""

 

LOG 2 - No carrier

    T.30 T2 timeout, expected page not received

 

    ---- Transcript of session follows ----

 

Oct 12 20:09:08.24: [ 1984]: SESSION BEGIN 000000052 330477818119
Oct 12 20:09:08.24: [ 1984]: HylaFAX (tm) Version 4.1.8
Oct 12 20:09:08.24: [ 1984]: <-- [13:AT+FCLASS=1A\r]
Oct 12 20:09:13.53: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:13.53: [ 1984]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Oct 12 20:09:13.53: [ 1984]: RECV FAX: begin
Oct 12 20:09:13.56: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:15.51: [ 1984]: --> [2:OK]
Oct 12 20:09:15.51: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:16.24: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:17.71: [ 1984]: --> [2:OK]
Oct 12 20:09:17.71: [ 1984]: REMOTE TSI "0477525066"
Oct 12 20:09:17.71: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:17.73: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:18.01: [ 1984]: --> [2:OK]
Oct 12 20:09:18.01: [ 1984]: REMOTE wants 9600 bit/s
Oct 12 20:09:18.01: [ 1984]: REMOTE wants page width 1728 pixels in 215 mm
Oct 12 20:09:18.01: [ 1984]: REMOTE wants unlimited page length
Oct 12 20:09:18.01: [ 1984]: REMOTE wants 3.85 line/mm
Oct 12 20:09:18.01: [ 1984]: REMOTE wants 2-D MR
Oct 12 20:09:18.01: [ 1984]: RECV training at v.29 9600 bit/s
Oct 12 20:09:18.01: [ 1984]: <-- [10:AT+FRM=96\r]
Oct 12 20:09:18.37: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:19.94: [ 1984]: RECV: TCF 1893 bytes, 18% non-zero, 792 zero-run
Oct 12 20:09:19.94: [ 1984]: RECV: reject TCF (too many non-zero, max 10%)
Oct 12 20:09:19.94: [ 1984]: RECV: reject TCF (zero run too short, min 1200)
Oct 12 20:09:19.95: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:19.95: [ 1984]: DELAY 75 ms
Oct 12 20:09:20.03: [ 1984]: <-- [9:AT+FTH=3\r]
Oct 12 20:09:20.23: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:21.40: [ 1984]: --> [2:OK]
Oct 12 20:09:21.40: [ 1984]: TRAINING failed
Oct 12 20:09:21.40: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:22.28: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:23.61: [ 1984]: --> [2:OK]
Oct 12 20:09:23.61: [ 1984]: REMOTE TSI "0477525066"
Oct 12 20:09:23.61: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:23.63: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:23.91: [ 1984]: --> [2:OK]
Oct 12 20:09:23.91: [ 1984]: REMOTE wants 7200 bit/s
Oct 12 20:09:23.91: [ 1984]: REMOTE wants page width 1728 pixels in 215 mm
Oct 12 20:09:23.91: [ 1984]: REMOTE wants unlimited page length
Oct 12 20:09:23.91: [ 1984]: REMOTE wants 3.85 line/mm
Oct 12 20:09:23.91: [ 1984]: REMOTE wants 2-D MR
Oct 12 20:09:23.91: [ 1984]: RECV training at v.29 7200 bit/s
Oct 12 20:09:23.91: [ 1984]: <-- [10:AT+FRM=72\r]
Oct 12 20:09:24.26: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:25.84: [ 1984]: RECV: TCF 1420 bytes, 7% non-zero, 1297 zero-run
Oct 12 20:09:25.84: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:25.84: [ 1984]: DELAY 75 ms
Oct 12 20:09:25.92: [ 1984]: TRAINING succeeded
Oct 12 20:09:25.92: [ 1984]: <-- [9:AT+FTH=3\r]
Oct 12 20:09:26.12: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:27.30: [ 1984]: --> [2:OK]
Oct 12 20:09:27.30: [ 1984]: <-- [10:AT+FRM=72\r]
Oct 12 20:09:28.23: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:28.23: [ 1984]: RECV: begin page
Oct 12 20:09:33.03: [ 1984]: RECV: 240 total lines, 6 bad lines, 2 consecutive bad lines
Oct 12 20:09:33.03: [ 1984]: RECV: end page
Oct 12 20:09:33.03: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:33.03: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.64: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:46.64: [ 1984]: MODEM No carrier
Oct 12 20:09:46.64: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.66: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:46.66: [ 1984]: MODEM No carrier
Oct 12 20:09:46.66: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.68: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:46.68: [ 1984]: MODEM No carrier
Oct 12 20:09:46.68: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.70: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:46.70: [ 1984]: MODEM No carrier
Oct 12 20:09:46.70: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.72: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:46.72: [ 1984]: MODEM No carrier
Oct 12 20:09:46.72: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.74: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:46.74: [ 1984]: MODEM No carrier
Oct 12 20:09:46.74: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.76: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:46.76: [ 1984]: MODEM No carrier
Oct 12 20:09:46.76: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:46.78: [ 1984]: --> [10:NO CARRIER]

...<snip>... I've these 3 lines so much time !
Oct 12 20:09:53.90: [ 1984]: MODEM No carrier
Oct 12 20:09:53.90: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:53.92: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:53.92: [ 1984]: MODEM No carrier
Oct 12 20:09:53.92: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:53.94: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:53.94: [ 1984]: MODEM No carrier
Oct 12 20:09:53.94: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:53.96: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:53.96: [ 1984]: MODEM No carrier
Oct 12 20:09:53.96: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:53.98: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:53.98: [ 1984]: MODEM No carrier
Oct 12 20:09:53.98: [ 1984]: <-- [9:AT+FRH=3\r]
Oct 12 20:09:54.00: [ 1984]: --> [10:NO CARRIER]
Oct 12 20:09:54.00: [ 1984]: MODEM No carrier
Oct 12 20:09:54.00: [ 1984]: RECV keeping unconfirmed page
Oct 12 20:09:54.00: [ 1984]: RECV FAX (000000052): from 0477525066, page 1 in 0:29, INF, 3.85 line/mm, 2-D MR, 7200 bit/s
Oct 12 20:09:54.00: [ 1984]: RECV FAX (000000052): recvq/fax000000038.tif from 0477525066, route to <unspecified>, 1 pages in 0:41
Oct 12 20:09:54.00: [ 1984]: RECV FAX: T.30 T2 timeout, expected page not received
Oct 12 20:09:54.00: [ 1984]: <-- [9:AT+FTH=3\r]
Oct 12 20:09:54.20: [ 1984]: --> [7:CONNECT]
Oct 12 20:09:55.38: [ 1984]: --> [2:OK]
Oct 12 20:09:55.38: [ 1984]: RECV FAX (000000052): session with 0477525066 terminated abnormally: T.30 T2 timeout, expected page not received
Oct 12 20:09:55.38: [ 1984]: RECV FAX: bin/faxrcvd "recvq/fax000000038.tif" "ttyS0" "000000052" "T.30 T2 timeout, expected page not received" "" ""

 

 

LOG 3 - Speak chinese ? :-)

    T.30 T2 timeout, expected page not received

 

    ---- Transcript of session follows ----

 

Oct 13 10:57:55.06: [ 1986]: SESSION BEGIN 000000049 330477963096
Oct 13 10:57:55.06: [ 1986]: HylaFAX (tm) Version 4.1.8
Oct 13 10:57:55.06: [ 1986]: <-- [13:AT+FCLASS=1A\r]
Oct 13 10:58:00.35: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:00.35: [ 1986]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Oct 13 10:58:00.35: [ 1986]: RECV FAX: begin
Oct 13 10:58:00.38: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:02.33: [ 1986]: --> [2:OK]
Oct 13 10:58:02.33: [ 1986]: <-- [9:AT+FRH=3\r]
Oct 13 10:58:03.17: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:04.50: [ 1986]: --> [2:OK]
Oct 13 10:58:04.50: [ 1986]: REMOTE TSI "0478377320"
Oct 13 10:58:04.50: [ 1986]: <-- [9:AT+FRH=3\r]
Oct 13 10:58:04.52: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:04.79: [ 1986]: --> [2:OK]
Oct 13 10:58:04.79: [ 1986]: REMOTE wants 9600 bit/s
Oct 13 10:58:04.79: [ 1986]: REMOTE wants page width 1728 pixels in 215 mm
Oct 13 10:58:04.79: [ 1986]: REMOTE wants unlimited page length
Oct 13 10:58:04.79: [ 1986]: REMOTE wants 3.85 line/mm
Oct 13 10:58:04.79: [ 1986]: REMOTE wants 2-D MR
Oct 13 10:58:04.79: [ 1986]: RECV training at v.29 9600 bit/s
Oct 13 10:58:04.79: [ 1986]: <-- [10:AT+FRM=96\r]
Oct 13 10:58:05.11: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:06.68: [ 1986]: RECV: TCF 1892 bytes, 4% non-zero, 1804 zero-run
Oct 13 10:58:06.69: [ 1986]: --> [10:NO CARRIER]
Oct 13 10:58:06.69: [ 1986]: DELAY 75 ms
Oct 13 10:58:06.77: [ 1986]: TRAINING succeeded
Oct 13 10:58:06.77: [ 1986]: <-- [9:AT+FTH=3\r]
Oct 13 10:58:06.97: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:08.15: [ 1986]: --> [2:OK]
Oct 13 10:58:08.15: [ 1986]: <-- [10:AT+FRM=96\r]
Oct 13 10:58:08.74: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:08.74: [ 1986]: RECV: begin page
Oct 13 10:58:22.92: [ 1986]: RECV: 1201 total lines, 0 bad lines, 0 consecutive bad lines
Oct 13 10:58:22.92: [ 1986]: RECV: end page
Oct 13 10:58:22.92: [ 1986]: --> [10:NO CARRIER]
Oct 13 10:58:22.92: [ 1986]: <-- [9:AT+FRH=3\r]
Oct 13 10:58:23.17: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:24.06: [ 1986]: --> [2:OK]
Oct 13 10:58:24.06: [ 1986]: RECV recv MPS (more pages, same document)
Oct 13 10:58:24.06: [ 1986]: <-- [9:AT+FRS=7\r]
Oct 13 10:58:24.17: [ 1986]: --> [2:OK]
Oct 13 10:58:24.17: [ 1986]: <-- [9:AT+FTH=3\r]
Oct 13 10:58:24.37: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:24.37: [ 1986]: RECV send MCF (message confirmation)
Oct 13 10:58:24.37: [ 1986]: RECV FAX (000000049): from 0478377320, page 1 in 0:18, INF, 3.85 line/mm, 2-D MR, 9600 bit/s
Oct 13 10:58:25.55: [ 1986]: --> [2:OK]
Oct 13 10:58:25.55: [ 1986]: <-- [10:AT+FRM=96\r]
Oct 13 10:58:26.14: [ 1986]: --> [7:CONNECT]
Oct 13 10:58:26.14: [ 1986]: RECV: begin page
Oct 13 10:59:03.67: [ 1986]: RECV: 1193 total lines, 0 bad lines, 0 consecutive bad lines
Oct 13 10:59:03.67: [ 1986]: RECV: end page
Oct 13 10:59:03.67: [ 1986]: --> [10:NO CARRIER]
Oct 13 10:59:03.67: [ 1986]: <-- [9:AT+FRH=3\r]
Oct 13 10:59:03.97: [ 1986]: --> [7:CONNECT]
Oct 13 10:59:04.78: [ 1986]: --> [2:OK]
Oct 13 10:59:04.78: [ 1986]: RECV recv MPS (more pages, same document)
Oct 13 10:59:04.78: [ 1986]: <-- [9:AT+FRS=7\r]
Oct 13 10:59:04.89: [ 1986]: --> [2:OK]
Oct 13 10:59:04.89: [ 1986]: <-- [9:AT+FTH=3\r]
Oct 13 10:59:05.09: [ 1986]: --> [7:CONNECT]
Oct 13 10:59:05.09: [ 1986]: RECV send MCF (message confirmation)
Oct 13 10:59:05.09: [ 1986]: RECV FAX (000000049): from 0478377320, page 2 in 0:41, INF, 3.85 line/mm, 2-D MR, 9600 bit/s
Oct 13 10:59:06.27: [ 1986]: --> [2:OK]
Oct 13 10:59:06.27: [ 1986]: <-- [10:AT+FRM=96\r]
Oct 13 10:59:06.86: [ 1986]: --> [7:CONNECT]
Oct 13 10:59:06.86: [ 1986]: RECV: begin page
Oct 13 10:59:21.68: [ 1986]: RECV: 1195 total lines, 0 bad lines, 0 consecutive bad lines
Oct 13 10:59:21.68: [ 1986]: RECV: end page
Oct 13 10:59:22.02: [ 1986]: --> [10:NO CARRIER]
Oct 13 10:59:22.02: [ 1986]: <-- [9:AT+FRH=3\r]
Oct 13 10:59:22.37: [ 1986]: --> [7:CONNECT]
Oct 13 10:59:22.81: [ 1986]: --> [2:OK]
Oct 13 10:59:22.81: [ 1986]: RECV recv MPS (more pages, same document)
Oct 13 10:59:22.81: [ 1986]: <-- [9:AT+FRS=7\r]
Oct 13 10:59:22.92: [ 1986]: --> [2:OK]
Oct 13 10:59:22.92: [ 1986]: <-- [9:AT+FTH=3\r]
Oct 13 10:59:52.92: [ 1986]: MODEM <Timeout>
Oct 13 10:59:52.92: [ 1986]: RECV send MCF (message confirmation)
Oct 13 10:59:52.92: [ 1986]: RECV FAX (000000049): from 0478377320, page 3 in 0:47, INF, 3.85 line/mm, 2-D MR, 9600 bit/s
Oct 13 10:59:55.47: [ 1986]: --> [5:ÿ?]
Oct 13 10:59:55.47: [ 1986]: <-- [10:AT+FRM=96\r]
Oct 13 10:59:55.71: [ 1986]: --> [9:AT+FRM=96]
Oct 13 10:59:55.71: [ 1986]: RECV keeping unconfirmed page
Oct 13 10:59:55.71: [ 1986]: RECV FAX (000000049): from 0478377320, page 4 in 0:03, INF, 3.85 line/mm, 2-D MR, 9600 bit/s
Oct 13 10:59:55.71: [ 1986]: RECV FAX (000000049): recvq/fax000000043.tif from 0478377320, route to <unspecified>, 4 pages in 1:55
Oct 13 10:59:55.71: [ 1986]: RECV FAX: T.30 T2 timeout, expected page not received
Oct 13 10:59:55.71: [ 1986]: <-- [9:AT+FTH=3\r]
Oct 13 10:59:55.71: [ 1986]: --> [5:ERROR]
Oct 13 10:59:55.71: [ 1986]: RECV FAX (000000049): session with 0478377320 terminated abnormally: T.30 T2 timeout, expected page not received
Oct 13 10:59:55.71: [ 1986]: RECV FAX: bin/faxrcvd "recvq/fax000000043.tif" "ttyS0" "000000049" "T.30 T2 timeout, expected page not received" "" ""