HylaFAX The world's most advanced open source fax server

[Date Prev][Date Next][Thread Prev][Thread Next] [Date Index] [Thread Index]

[hylafax-users] USR Courier V. Everything Performance



Hello

 

I appreciated Lee's input on my USR 33.6 External issue, that modem has since returned to the bin in which it was found.

I performed a garbage upgrade and attached a USR Courier V. Everything to hylafax, which has actually managed to receive all pages sent to it so far (still using the 13 page test) from the HP T45xi/deskjet FAX.

My problem now is performance.

With the 56K voice and 33.6 fax modems, I could expect to receive all 13 pages (on occasions when errors were absent) in around 3 minutes.

With the Courier V. configured as a class 1 device, I can expect 13+ minutes to receive all 13 pages.

With the Courier V. configured as a class 2.0 device, I can expect a receive time of just over 5 minutes (still significantly longer than the sportsters).

 

I have noticed that as a class 1 device, there appears to be some difficulties encountered with HDLC frames/termination, and perhaps this is "fixable".

Here is a typical log from Courier V. configured as a class 1:

Dec 21 09:01:08.32: [ 6380]: SESSION BEGIN 000000395 14146152598

Dec 21 09:01:08.32: [ 6380]: HylaFAX (tm) Version 4.2.0

Dec 21 09:01:08.32: [ 6380]: <-- [22:AT+FCLASS=1&H1&I0&R2A\r]

Dec 21 09:01:13.69: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:13.69: [ 6380]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'

Dec 21 09:01:13.69: [ 6380]: RECV FAX: begin

Dec 21 09:01:13.69: [ 6380]: <-- data [32]

Dec 21 09:01:13.69: [ 6380]: <-- data [2]

Dec 21 09:01:15.57: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:15.57: [ 6380]: <-- data [23]

Dec 21 09:01:15.57: [ 6380]: <-- data [2]

Dec 21 09:01:16.73: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:16.73: [ 6380]: <-- data [10]

Dec 21 09:01:16.73: [ 6380]: <-- data [2]

Dec 21 09:01:17.55: [ 6380]: --> [2:OK]

Dec 21 09:01:17.55: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:01:19.17: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:19.84: [ 6380]: --> [2:OK]

Dec 21 09:01:19.84: [ 6380]: REMOTE TSI "4146152434"

Dec 21 09:01:19.84: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:01:19.88: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:20.19: [ 6380]: --> [2:OK]

Dec 21 09:01:20.19: [ 6380]: REMOTE wants 14400 bit/s

Dec 21 09:01:20.20: [ 6380]: REMOTE wants A4 page width (215 mm)

Dec 21 09:01:20.20: [ 6380]: REMOTE wants unlimited page length

Dec 21 09:01:20.20: [ 6380]: REMOTE wants 7.7 line/mm

Dec 21 09:01:20.20: [ 6380]: REMOTE wants 2-D MMR

Dec 21 09:01:20.20: [ 6380]: REMOTE wants T.30 Annex A, 256-byte ECM

Dec 21 09:01:20.20: [ 6380]: RECV training at v.17 14400 bit/s

Dec 21 09:01:20.20: [ 6380]: <-- [11:AT+FRM=145\r]

Dec 21 09:01:21.91: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:23.47: [ 6380]: RECV: TCF 2827 bytes, 3% non-zero, 2710 zero-run

Dec 21 09:01:23.49: [ 6380]: --> [10:NO CARRIER]

Dec 21 09:01:23.49: [ 6380]: DELAY 75 ms

Dec 21 09:01:23.57: [ 6380]: TRAINING succeeded

Dec 21 09:01:23.57: [ 6380]: <-- [9:AT+FTH=3\r]

Dec 21 09:01:23.68: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:23.68: [ 6380]: <-- data [3]

Dec 21 09:01:23.68: [ 6380]: <-- data [2]

Dec 21 09:01:24.90: [ 6380]: --> [2:OK]

Dec 21 09:01:24.90: [ 6380]: <-- [11:AT+FRM=146\r]

Dec 21 09:01:25.93: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:26.28: [ 6380]: RECV received frame number 0

Dec 21 09:01:26.42: [ 6380]: RECV received frame number 1

...

Dec 21 09:01:37.40: [ 6380]: RECV received frame number 41

Dec 21 09:01:37.40: [ 6380]: RECV received RCP frame

Dec 21 09:01:37.55: [ 6380]: --> [10:NO CARRIER]

Dec 21 09:01:37.55: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:01:38.53: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:38.78: [ 6380]: --> [2:OK]

Dec 21 09:01:38.78: [ 6380]: RECV recv PPS (partial page signal)

Dec 21 09:01:38.78: [ 6380]: RECV recv MPS (more pages, same document)

Dec 21 09:01:38.78: [ 6380]: RECV received 42 frames of block 1 of page 1

Dec 21 09:01:38.78: [ 6380]: <-- [9:AT+FRS=7\r]

Dec 21 09:01:38.89: [ 6380]: --> [2:OK]

Dec 21 09:01:38.96: [ 6380]: RECV: 10576 bytes of data, 2190 total lines

Dec 21 09:01:38.96: [ 6380]: <-- [9:AT+FTH=3\r]

Dec 21 09:01:39.08: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:39.08: [ 6380]: RECV send MCF (message confirmation)

Dec 21 09:01:39.08: [ 6380]: RECV FAX (000000395): from 4146152434, page 1 in 0:16, INF, 7.7 line/mm, 2-D MMR, 14400 bit/s

Dec 21 09:01:39.08: [ 6380]: <-- data [3]

Dec 21 09:01:39.08: [ 6380]: <-- data [2]

Dec 21 09:01:40.29: [ 6380]: --> [2:OK]

Dec 21 09:01:40.29: [ 6380]: <-- [11:AT+FRM=146\r]

Dec 21 09:01:41.26: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:42.40: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0x80

Dec 21 09:01:42.68: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0

Dec 21 09:01:43.25: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:01:43.39: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:01:43.53: [ 6380]: HDLC frame with bad address field 0x8a

Dec 21 09:01:43.68: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0xfc

Dec 21 09:01:43.68: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:01:43.82: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0

Dec 21 09:01:43.89: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0x80

Dec 21 09:01:43.96: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:01:44.10: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:01:44.31: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:01:44.38: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0

...

(132 more lines of HDLC errors)

...

Dec 21 09:01:55.24: [ 6380]: RECV assumed RCP frame with block end

Dec 21 09:01:55.24: [ 6380]: --> [10:NO CARRIER]

Dec 21 09:01:55.24: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:01:56.28: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:56.52: [ 6380]: --> [2:OK]

Dec 21 09:01:56.52: [ 6380]: RECV recv PPS (partial page signal)

Dec 21 09:01:56.52: [ 6380]: RECV recv MPS (more pages, same document)

Dec 21 09:01:56.52: [ 6380]: RECV received 90 frames of block 1 of page 2

Dec 21 09:01:56.52: [ 6380]: <-- [9:AT+FRS=7\r]

Dec 21 09:01:56.63: [ 6380]: --> [2:OK]

Dec 21 09:01:56.63: [ 6380]: <-- [9:AT+FTH=3\r]

Dec 21 09:01:56.75: [ 6380]: --> [7:CONNECT]

Dec 21 09:01:56.75: [ 6380]: <-- data [35]

Dec 21 09:01:56.75: [ 6380]: <-- data [2]

Dec 21 09:01:58.99: [ 6380]: --> [2:OK]

Dec 21 09:01:58.99: [ 6380]: RECV send PPR (partial page request)

Dec 21 09:01:58.99: [ 6380]: <-- [11:AT+FRM=146\r]

Dec 21 09:01:59.97: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:01.67: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0xe0

Dec 21 09:02:01.89: [ 6380]: HDLC frame with bad address field 0x91

Dec 21 09:02:02.03: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0x80

Dec 21 09:02:02.38: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:02:02.60: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:02:02.74: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0xf0

Dec 21 09:02:02.88: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:02:02.95: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:02:03.23: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0xfc

...

(109 more lines of HDLC errors)

...

Dec 21 09:02:13.72: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:02:14.05: [ 6380]: RECV assumed RCP frame with block end

Dec 21 09:02:14.05: [ 6380]: --> [10:NO CARRIER]

Dec 21 09:02:14.05: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:02:15.01: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:15.26: [ 6380]: --> [2:OK]

Dec 21 09:02:15.26: [ 6380]: RECV recv PPS (partial page signal)

Dec 21 09:02:15.26: [ 6380]: RECV recv MPS (more pages, same document)

Dec 21 09:02:15.26: [ 6380]: RECV received 90 frames of block 1 of page 2

Dec 21 09:02:15.26: [ 6380]: <-- [9:AT+FRS=7\r]

Dec 21 09:02:15.37: [ 6380]: --> [2:OK]

Dec 21 09:02:15.37: [ 6380]: <-- [9:AT+FTH=3\r]

Dec 21 09:02:15.49: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:15.49: [ 6380]: <-- data [35]

Dec 21 09:02:15.49: [ 6380]: <-- data [2]

Dec 21 09:02:17.72: [ 6380]: --> [2:OK]

Dec 21 09:02:17.72: [ 6380]: RECV send PPR (partial page request)

Dec 21 09:02:17.72: [ 6380]: <-- [11:AT+FRM=146\r]

Dec 21 09:02:18.71: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:20.77: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:02:21.13: [ 6380]: Bad HDLC terminating flag received.

Dec 21 09:02:21.41: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0xe0

...

Dec 21 09:02:51.12: [ 6380]: HDLC frame not byte-oriented.  Trailing byte: 0x80

Dec 21 09:02:51.50: [ 6380]: RECV assumed RCP frame with block end

Dec 21 09:02:51.50: [ 6380]: --> [10:NO CARRIER]

Dec 21 09:02:51.50: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:02:52.43: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:52.68: [ 6380]: --> [2:OK]

Dec 21 09:02:52.68: [ 6380]: RECV recv PPS (partial page signal)

Dec 21 09:02:52.68: [ 6380]: RECV recv MPS (more pages, same document)

Dec 21 09:02:52.68: [ 6380]: RECV received 90 frames of block 1 of page 2

Dec 21 09:02:52.68: [ 6380]: <-- [9:AT+FRS=7\r]

Dec 21 09:02:52.79: [ 6380]: --> [2:OK]

Dec 21 09:02:52.79: [ 6380]: <-- [9:AT+FTH=3\r]

Dec 21 09:02:52.91: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:52.91: [ 6380]: <-- data [35]

Dec 21 09:02:52.91: [ 6380]: <-- data [2]

Dec 21 09:02:55.14: [ 6380]: --> [2:OK]

Dec 21 09:02:55.15: [ 6380]: RECV send PPR (partial page request)

Dec 21 09:02:55.15: [ 6380]: RECV sent fourth PPR

Dec 21 09:02:55.15: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:02:56.27: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:56.46: [ 6380]: --> [2:OK]

Dec 21 09:02:56.46: [ 6380]: RECV recv CTC (continue to correct)

Dec 21 09:02:56.46: [ 6380]: <-- [9:AT+FRS=7\r]

Dec 21 09:02:56.57: [ 6380]: --> [2:OK]

Dec 21 09:02:56.57: [ 6380]: <-- [9:AT+FTH=3\r]

Dec 21 09:02:56.69: [ 6380]: --> [7:CONNECT]

Dec 21 09:02:56.69: [ 6380]: <-- data [3]

Dec 21 09:02:56.69: [ 6380]: <-- data [2]

Dec 21 09:02:57.91: [ 6380]: --> [2:OK]

Dec 21 09:02:57.91: [ 6380]: RECV send CTR (confirm continue to correct)

Dec 21 09:02:57.91: [ 6380]: <-- [11:AT+FRM=121\r]

Dec 21 09:03:00.21: [ 6380]: --> [7:CONNECT]

Dec 21 09:03:00.55: [ 6380]: RECV received frame number 0

Dec 21 09:03:00.80: [ 6380]: RECV received frame number 1

Dec 21 09:03:00.97: [ 6380]: RECV received frame number 2

...

Dec 21 09:14:04.20: [ 6380]: RECV received frame number 62

Dec 21 09:14:04.20: [ 6380]: RECV received RCP frame

Dec 21 09:14:07.65: [ 6380]: MODEM <Timeout>

Dec 21 09:14:09.65: [ 6380]: MODEM <Empty line>

Dec 21 09:14:11.65: [ 6380]: MODEM <Empty line>

Dec 21 09:14:11.65: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:14:11.66: [ 6380]: --> [2:OK]

Dec 21 09:14:11.66: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:14:13.93: [ 6380]: --> [7:CONNECT]

Dec 21 09:14:14.18: [ 6380]: --> [2:OK]

Dec 21 09:14:14.18: [ 6380]: RECV recv PPS (partial page signal)

Dec 21 09:14:14.18: [ 6380]: RECV recv EOP (no more pages or documents)

Dec 21 09:14:14.18: [ 6380]: RECV received 63 frames of block 1 of page 13

Dec 21 09:14:14.18: [ 6380]: <-- [9:AT+FRS=7\r]

Dec 21 09:14:14.29: [ 6380]: --> [2:OK]

Dec 21 09:14:14.41: [ 6380]: RECV: 16101 bytes of data, 2189 total lines

Dec 21 09:14:14.41: [ 6380]: <-- [9:AT+FTH=3\r]

Dec 21 09:14:14.52: [ 6380]: --> [7:CONNECT]

Dec 21 09:14:14.52: [ 6380]: <-- data [3]

Dec 21 09:14:14.52: [ 6380]: <-- data [2]

Dec 21 09:14:15.73: [ 6380]: --> [2:OK]

Dec 21 09:14:15.73: [ 6380]: RECV send MCF (message confirmation)

Dec 21 09:14:15.73: [ 6380]: RECV FAX (000000395): from 4146152434, page 13 in 1:12, INF, 7.7 line/mm, 2-D MMR, 14400 bit/s

Dec 21 09:14:15.73: [ 6380]: RECV FAX (000000395): recvq/fax000000373.tif from 4146152434, route to <unspecified>, 13 pages in 13:02

Dec 21 09:14:15.73: [ 6380]: <-- [9:AT+FRH=3\r]

Dec 21 09:14:16.90: [ 6380]: --> [7:CONNECT]

Dec 21 09:14:17.03: [ 6380]: --> [2:OK]

Dec 21 09:14:17.03: [ 6380]: RECV FAX: bin/faxrcvd "recvq/fax000000373.tif" "ttyS0" "000000395" "" "" ""

Dec 21 09:14:17.04: [ 6380]: RECV FAX: end

Dec 21 09:14:17.04: [ 6380]: SESSION END

 

A typical class 1 log contains 4300 lines, as opposed to 200 lines in a class 2 log.

 

Questions:

  1. Is there something that I can do to address the HDLC errors (apart from purchasing another modem) so I can run in class 1?
  2. When in class 1, the remote wants 2-D MMR, but in class 2.0 the same remote wants 1-D MH.  Does this account for the 2 minute speed difference between sportster receives and courier class 2.0 receives?  Is there anything that would remedy this behavior?

 

Thank you again for your much appreciated help!

 

 

AD




Project hosted by iFAX Solutions