[hylafax-users] T.30 T2 timeout errors

["Steve Melo" <smelo@xxxxxxxxxxxxxxxxx>]

Lee Howard,

Thank you for taking interest in my problem.  I changed the SessionTracing
as you suggested and have been waiting for a fax to fail. Finally a fax
failed with the T.30 T2 timeout error, here is the log:

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

Jul 12 16:19:31.47: [15990]: SESSION BEGIN 00002399 14164167632444
Jul 12 16:19:31.47: [15990]: HylaFAX (tm) Version 4.1.8
Jul 12 16:19:31.47: [15990]: MODEM set XON/XOFF/FLUSH: input ignored, output
disabled
Jul 12 16:19:31.47: [15990]: <-- [13:AT+FCLASS=1A\r]
Jul 12 16:19:36.26: [15990]: --> [7:CONNECT]
Jul 12 16:19:36.26: [15990]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS1'
Jul 12 16:19:36.26: [15990]: STATE CHANGE: ANSWERING -> RECEIVING
Jul 12 16:19:36.26: [15990]: MODEM input buffering enabled
Jul 12 16:19:36.26: [15990]: RECV FAX: begin
Jul 12 16:19:36.32: [15990]: MODEM input buffering disabled
Jul 12 16:19:36.32: [15990]: <-- HDLC<23:FF C0 02 2E CE AE 4E 2A 04 9E 2E 96
76 AE B6 B6 F6 C2 04 04 04 04 04>
Jul 12 16:19:36.35: [15990]: --> [7:CONNECT]
Jul 12 16:19:36.35: [15990]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03 C0>
Jul 12 16:19:38.24: [15990]: --> [2:OK]
Jul 12 16:19:38.24: [15990]: <-- [9:AT+FRH=3\r]
Jul 12 16:19:38.76: [15990]: --> [7:CONNECT]
Jul 12 16:19:39.83: [15990]: --> HDLC<9:FF C8 C1 00 45 19 00 CE 6D>
Jul 12 16:19:39.83: [15990]: --> [2:OK]
Jul 12 16:19:39.83: [15990]: REMOTE wants 14400 bit/s
Jul 12 16:19:39.83: [15990]: REMOTE wants page width 1728 pixels in 215 mm
Jul 12 16:19:39.83: [15990]: REMOTE wants unlimited page length
Jul 12 16:19:39.83: [15990]: REMOTE wants 3.85 line/mm
Jul 12 16:19:39.83: [15990]: REMOTE wants 2-D MR
Jul 12 16:19:39.83: [15990]: RECV training at v.17 14400 bit/s
Jul 12 16:19:39.83: [15990]: MODEM set XON/XOFF/DRAIN: input ignored, output
generated
Jul 12 16:19:39.83: [15990]: <-- [11:AT+FRM=145\r]
Jul 12 16:19:41.53: [15990]: --> [7:CONNECT]
Jul 12 16:19:43.03: [15990]: MODEM set XON/XOFF/DRAIN: input ignored, output
disabled
Jul 12 16:19:43.03: [15990]: RECV: TCF 2721 bytes, 0% non-zero, 2680
zero-run
Jul 12 16:19:43.04: [15990]: --> [10:NO CARRIER]
Jul 12 16:19:43.04: [15990]: DELAY 75 ms
Jul 12 16:19:43.12: [15990]: TRAINING succeeded
Jul 12 16:19:43.12: [15990]: <-- [9:AT+FTH=3\r]
Jul 12 16:19:43.32: [15990]: --> [7:CONNECT]
Jul 12 16:19:43.32: [15990]: <-- HDLC<3:FF C8 21>
Jul 12 16:19:44.50: [15990]: --> [2:OK]
Jul 12 16:19:44.50: [15990]: MODEM input buffering enabled
Jul 12 16:19:44.50: [15990]: MODEM set XON/XOFF/FLUSH: input ignored, output
generated
Jul 12 16:19:44.50: [15990]: <-- [11:AT+FRM=146\r]
Jul 12 16:19:45.21: [15990]: --> [7:CONNECT]
Jul 12 16:19:45.21: [15990]: RECV: begin page
Jul 12 16:19:59.23: [15990]: RECV/CQ: Bad 1D pixel count, row 1063, got 0,
expected 1728
Jul 12 16:19:59.23: [15990]: RECV/CQ: Bad 1D pixel count, row 1064, got 0,
expected 1728
Jul 12 16:19:59.23: [15990]: RECV/CQ: Bad 1D pixel count, row 1065, got 0,
expected 1728
Jul 12 16:19:59.23: [15990]: RECV/CQ: Bad 1D pixel count, row 1066, got 0,
expected 1728
Jul 12 16:19:59.23: [15990]: RECV/CQ: Bad 1D pixel count, row 1067, got 0,
expected 1728
Jul 12 16:19:59.37: [15990]: RECV/CQ: Adjusting for RTC found at row 1062
Jul 12 16:19:59.37: [15990]: RECV: 1062 total lines, 0 bad lines, 0
consecutive bad lines
Jul 12 16:19:59.37: [15990]: RECV: end page
Jul 12 16:19:59.37: [15990]: --> [10:NO CARRIER]
Jul 12 16:19:59.37: [15990]: MODEM set XON/XOFF/DRAIN: input ignored, output
disabled
Jul 12 16:19:59.37: [15990]: MODEM input buffering disabled
Jul 12 16:19:59.37: [15990]: <-- [9:AT+FRH=3\r]
Jul 12 16:19:59.56: [15990]: --> [7:CONNECT]
Jul 12 16:20:00.53: [15990]: --> HDLC<5:FF C8 F2 AC A0>
Jul 12 16:20:00.53: [15990]: --> [2:OK]
Jul 12 16:20:00.53: [15990]: RECV recv MPS (more pages, same document)
Jul 12 16:20:00.53: [15990]: <-- [9:AT+FRS=7\r]
Jul 12 16:20:00.64: [15990]: --> [2:OK]
Jul 12 16:20:00.64: [15990]: <-- [9:AT+FTH=3\r]
Jul 12 16:20:00.84: [15990]: --> [7:CONNECT]
Jul 12 16:20:00.84: [15990]: RECV send MCF (message confirmation)
Jul 12 16:20:00.84: [15990]: RECV FAX (00002399): from <UNSPECIFIED>, page 1
in 0:17, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
Jul 12 16:20:00.84: [15990]: <-- HDLC<3:FF C8 31>
Jul 12 16:20:02.02: [15990]: --> [2:OK]
Jul 12 16:20:02.02: [15990]: MODEM input buffering enabled
Jul 12 16:20:02.02: [15990]: MODEM set XON/XOFF/FLUSH: input ignored, output
generated
Jul 12 16:20:02.02: [15990]: <-- [11:AT+FRM=146\r]
Jul 12 16:20:02.82: [15990]: --> [7:CONNECT]
Jul 12 16:20:02.82: [15990]: RECV: begin page
Jul 12 16:20:23.38: [15990]: RECV/CQ: Bad 1D pixel count, row 1069, got 0,
expected 1728
Jul 12 16:20:23.38: [15990]: RECV/CQ: Bad 1D pixel count, row 1070, got 0,
expected 1728
Jul 12 16:20:23.38: [15990]: RECV/CQ: Bad 1D pixel count, row 1071, got 0,
expected 1728
Jul 12 16:20:23.38: [15990]: RECV/CQ: Bad 1D pixel count, row 1072, got 0,
expected 1728
Jul 12 16:20:23.38: [15990]: RECV/CQ: Bad 1D pixel count, row 1073, got 0,
expected 1728
Jul 12 16:20:23.38: [15990]: RECV/CQ: Adjusting for RTC found at row 1068
Jul 12 16:20:23.38: [15990]: RECV: 1068 total lines, 0 bad lines, 0
consecutive bad lines
Jul 12 16:20:23.38: [15990]: RECV: end page
Jul 12 16:20:23.38: [15990]: --> [10:NO CARRIER]
Jul 12 16:20:23.38: [15990]: MODEM set XON/XOFF/DRAIN: input ignored, output
disabled
Jul 12 16:20:23.38: [15990]: MODEM input buffering disabled
Jul 12 16:20:23.38: [15990]: <-- [9:AT+FRH=3\r]
Jul 12 16:20:23.56: [15990]: --> [7:CONNECT]
Jul 12 16:20:24.57: [15990]: --> HDLC<5:FF C8 F2 AC A0>
Jul 12 16:20:24.57: [15990]: --> [2:OK]
Jul 12 16:20:24.57: [15990]: RECV recv MPS (more pages, same document)
Jul 12 16:20:24.57: [15990]: <-- [9:AT+FRS=7\r]
Jul 12 16:20:24.68: [15990]: --> [2:OK]
Jul 12 16:20:24.68: [15990]: <-- [9:AT+FTH=3\r]
Jul 12 16:20:54.68: [15990]: MODEM TIMEOUT: reading line from modem
Jul 12 16:20:54.68: [15990]: MODEM <Timeout>
Jul 12 16:20:54.68: [15990]: RECV send MCF (message confirmation)
Jul 12 16:20:54.68: [15990]: RECV FAX (00002399): from <UNSPECIFIED>, page 2
in 0:54, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
Jul 12 16:20:54.68: [15990]: <-- HDLC<3:FF C8 31>
Jul 12 16:20:57.23: [15990]: --> [5:ÿO]
Jul 12 16:20:57.23: [15990]: MODEM TIMEOUT: sending HDLC frame
Jul 12 16:20:57.23: [15990]: MODEM input buffering enabled
Jul 12 16:20:57.23: [15990]: MODEM set XON/XOFF/FLUSH: input ignored, output
generated
Jul 12 16:20:57.23: [15990]: <-- [11:AT+FRM=146\r]
Jul 12 16:20:57.47: [15990]: --> [10:AT+FRM=146]
Jul 12 16:20:57.47: [15990]: MODEM set XON/XOFF/DRAIN: input ignored, output
disabled
Jul 12 16:20:57.47: [15990]: MODEM input buffering disabled
Jul 12 16:20:57.47: [15990]: RECV FAX (00002399): recvq/fax01919.tif from
<UNSPECIFIED>, route to <unspecified>, 2 pages in 1:21
Jul 12 16:20:57.48: [15990]: RECV FAX: T.30 T2 timeout, expected page not
received
Jul 12 16:20:57.48: [15990]: <-- [9:AT+FTH=3\r]
Jul 12 16:20:57.48: [15990]: --> [5:ERROR]
Jul 12 16:20:57.48: [15990]: MODEM input buffering enabled
Jul 12 16:20:57.48: [15990]: RECV FAX (00002399): session with <UNSPECIFIED>
terminated abnormally: T.30 T2 timeout, expected page not received
Jul 12 16:20:57.48: [15990]: RECV FAX: bin/faxrcvd "recvq/fax01919.tif"
"ttyS1" "00002399" "T.30 T2 timeout, expected page not received" "" ""



____________________ 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@xxxxxxxxxxx < /dev/null
  *To learn about commercial HylaFAX(tm) support, mail sales@xxxxxxxxx*