HylaFAX The world's
most advanced open source fax server
|
|
[
Date Prev][
Date Next][
Thread Prev][
Thread Next]
[
Date Index]
[
Thread Index]
[hylafax-users] MT5634ZBA Error
We just purchased a new MultiTech MT5634ZBA modem (running class 1) for
testing purposes and we've had a total of 1 error since last Thursday
(0.4%). However, for the sake of being a perfectionist, does anyone
have any suggestions on why this happened (log attached)?
Nothing special in my config file except rtscts flow-control and 19200
baud.
--
Michael T. Babcock
CTO, FibreSpeed Ltd. (Hosting, Security, Consultation, Database, etc)
http://www.fibrespeed.net/~mbabcock/
Oct 26 01:05:50.12: [ 9168]: SESSION BEGIN 00153707 1xxxxxxxxxx
Oct 26 01:05:50.12: [ 9168]: HylaFAX (tm) Version 4.1.3
Oct 26 01:05:50.12: [ 9168]: SEND FAX: JOB 18547 DEST 1xxx-xxx-xxxx COMMID 00153707 DEVICE '/dev/ttyS1'
Oct 26 01:05:50.12: [ 9168]: MODEM set DTR OFF
Oct 26 01:05:50.12: [ 9168]: DELAY 75 ms
Oct 26 01:05:50.21: [ 9168]: MODEM set DTR ON
Oct 26 01:05:50.21: [ 9168]: DELAY 2600 ms
Oct 26 01:05:52.81: [ 9168]: MODEM set baud rate: 19200 baud, input flow RTS/CTS, output flow RTS/CTS
Oct 26 01:05:52.81: [ 9168]: MODEM flush i/o
Oct 26 01:05:52.81: [ 9168]: <-- [4:ATZ\r]
Oct 26 01:05:53.75: [ 9168]: --> [2:OK]
Oct 26 01:05:53.75: [ 9168]: DELAY 3000 ms
Oct 26 01:05:56.75: [ 9168]: <-- [5:ATE0\r]
Oct 26 01:05:56.76: [ 9168]: --> [4:ATE0]
Oct 26 01:05:56.76: [ 9168]: --> [2:OK]
Oct 26 01:05:56.76: [ 9168]: <-- [5:ATV1\r]
Oct 26 01:05:56.77: [ 9168]: --> [2:OK]
Oct 26 01:05:56.77: [ 9168]: <-- [5:ATQ0\r]
Oct 26 01:05:56.78: [ 9168]: --> [2:OK]
Oct 26 01:05:56.78: [ 9168]: <-- [7:ATS0=0\r]
Oct 26 01:05:56.80: [ 9168]: --> [2:OK]
Oct 26 01:05:56.80: [ 9168]: <-- [7:ATS8=2\r]
Oct 26 01:05:56.82: [ 9168]: --> [2:OK]
Oct 26 01:05:56.82: [ 9168]: <-- [8:ATS7=60\r]
Oct 26 01:05:56.84: [ 9168]: --> [2:OK]
Oct 26 01:05:56.84: [ 9168]: <-- [12:AT+FCLASS=1\r]
Oct 26 01:05:56.86: [ 9168]: --> [2:OK]
Oct 26 01:05:56.86: [ 9168]: <-- [7:ATL1M1\r]
Oct 26 01:05:56.88: [ 9168]: --> [2:OK]
Oct 26 01:05:56.88: [ 9168]: STATE CHANGE: RUNNING -> SENDING
Oct 26 01:05:56.88: [ 9168]: MODEM input buffering enabled
Oct 26 01:05:56.88: [ 9168]: <-- [12:AT+FCLASS=1\r]
Oct 26 01:05:57.00: [ 9168]: --> [2:OK]
Oct 26 01:05:57.00: [ 9168]: DIAL 1xxxxxxxxxx
Oct 26 01:05:57.00: [ 9168]: <-- [16:ATDT1xxxxxxxxxx\r]
Oct 26 01:06:17.11: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:17.11: [ 9168]: MODEM input buffering disabled
Oct 26 01:06:19.11: [ 9168]: --> HDLC<38:FF C0 04 00 00 88 01 00 51 92 08 82 32 32 B2 82 4A 04 22 92 CA 2A 4A 92 42 AA 2A 00 CA 00 01 01 01 30 80 60 7F F2>
Oct 26 01:06:19.11: [ 9168]: --> [2:OK]
Oct 26 01:06:19.11: [ 9168]: REMOTE NSF "00 00 11 80 00 8A 49 10 41 4C 4C 4D 41 52 20 44 49 53 54 52 49 42 55 54 00 53 00 80 80 80 0C 01 06 FE"
Oct 26 01:06:19.11: [ 9168]: NSF remote fax equipment: Canon Laser Class 9000 Series
Oct 26 01:06:19.11: [ 9168]: NSF remote station ID: "yyyyyyyyyyyyyyyy"
Oct 26 01:06:19.11: [ 9168]: <-- [9:AT+FRH=3\r]
Oct 26 01:06:19.13: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:19.80: [ 9168]: --> HDLC<25:FF C0 02 AC 0C 9C 8C 04 EC 2C 2C 04 0C 1C EC 04 04 04 04 04 04 04 04 20 59>
Oct 26 01:06:19.80: [ 9168]: --> [2:OK]
Oct 26 01:06:19.80: [ 9168]: REMOTE CSI "xxx xxx xxxx"
Oct 26 01:06:19.80: [ 9168]: <-- [9:AT+FRH=3\r]
Oct 26 01:06:19.82: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:20.23: [ 9168]: --> HDLC<15:FF C8 01 04 77 95 23 01 A9 01 01 01 1C 99 07>
Oct 26 01:06:20.23: [ 9168]: --> [2:OK]
Oct 26 01:06:20.23: [ 9168]: REMOTE best rate 33600 bit/s
Oct 26 01:06:20.23: [ 9168]: REMOTE max page width 2048 pixels in 255 mm
Oct 26 01:06:20.23: [ 9168]: REMOTE max unlimited page length
Oct 26 01:06:20.23: [ 9168]: REMOTE best vres 7.7 line/mm
Oct 26 01:06:20.23: [ 9168]: REMOTE best format 2-D MMR
Oct 26 01:06:20.23: [ 9168]: REMOTE supports T.30 Annex A, ECM
Oct 26 01:06:20.23: [ 9168]: REMOTE best 10 ms/scanline
Oct 26 01:06:20.23: [ 9168]: USE 14400 bit/s
Oct 26 01:06:20.23: [ 9168]: USE 10 ms/scanline
Oct 26 01:06:20.23: [ 9168]: SEND file "docq/doc18736.ps;71"
Oct 26 01:06:20.23: [ 9168]: USE page width 1728 pixels in 215 mm
Oct 26 01:06:20.23: [ 9168]: USE unlimited page length
Oct 26 01:06:20.23: [ 9168]: USE 7.7 line/mm
Oct 26 01:06:20.23: [ 9168]: USE 2-D MR
Oct 26 01:06:20.23: [ 9168]: SEND training at v.17 14400 bit/s
Oct 26 01:06:20.23: [ 9168]: <-- [9:AT+FTH=3\r]
Oct 26 01:06:21.21: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:21.21: [ 9168]: <-- HDLC<23:FF C0 C2 8C C4 04 86 26 86 76 86 C2 04 9E F6 36 46 82 04 86 CE CE 82>
Oct 26 01:06:21.21: [ 9168]: <-- data [23]
Oct 26 01:06:21.21: [ 9168]: <-- data [2]
Oct 26 01:06:21.23: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:21.24: [ 9168]: <-- HDLC<6:FF C8 C1 00 47 14>
Oct 26 01:06:21.24: [ 9168]: <-- data [6]
Oct 26 01:06:21.24: [ 9168]: <-- data [2]
Oct 26 01:06:22.50: [ 9168]: --> [2:OK]
Oct 26 01:06:22.51: [ 9168]: <-- [9:AT+FTS=7\r]
Oct 26 01:06:22.57: [ 9168]: --> [2:OK]
Oct 26 01:06:22.58: [ 9168]: <-- [11:AT+FTM=145\r]
Oct 26 01:06:22.59: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:22.60: [ 9168]: <-- data [1024]
Oct 26 01:06:22.60: [ 9168]: <-- data [1024]
Oct 26 01:06:22.60: [ 9168]: <-- data [652]
Oct 26 01:06:22.60: [ 9168]: <-- data [2]
Oct 26 01:06:25.76: [ 9168]: --> [2:OK]
Oct 26 01:06:25.77: [ 9168]: <-- [9:AT+FRH=3\r]
Oct 26 01:06:25.95: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:27.15: [ 9168]: --> HDLC<5:FF C8 21 57 BE>
Oct 26 01:06:27.15: [ 9168]: --> [2:OK]
Oct 26 01:06:27.15: [ 9168]: TRAINING succeeded
Oct 26 01:06:27.16: [ 9168]: DELAY 75 ms
Oct 26 01:06:27.23: [ 9168]: <-- [11:AT+FTM=146\r]
Oct 26 01:06:27.25: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:27.25: [ 9168]: SEND begin page
Oct 26 01:06:27.26: [ 9168]: <-- data [1029]
Oct 26 01:06:27.26: [ 9168]: <-- data [1030]
Oct 26 01:06:27.26: [ 9168]: <-- data [1029]
Oct 26 01:06:27.26: [ 9168]: <-- data [1026]
Oct 26 01:06:29.28: [ 9168]: <-- data [1036]
Oct 26 01:06:29.28: [ 9168]: <-- data [1032]
Oct 26 01:06:29.28: [ 9168]: <-- data [1028]
Oct 26 01:06:29.28: [ 9168]: <-- data [1030]
Oct 26 01:06:31.28: [ 9168]: <-- data [1027]
Oct 26 01:06:31.28: [ 9168]: <-- data [1029]
Oct 26 01:06:31.28: [ 9168]: <-- data [1030]
Oct 26 01:06:31.28: [ 9168]: <-- data [1033]
Oct 26 01:06:33.28: [ 9168]: <-- data [1027]
Oct 26 01:06:33.28: [ 9168]: <-- data [1031]
Oct 26 01:06:33.28: [ 9168]: <-- data [1030]
Oct 26 01:06:33.28: [ 9168]: <-- data [1027]
Oct 26 01:06:35.28: [ 9168]: <-- data [1028]
Oct 26 01:06:35.28: [ 9168]: <-- data [1031]
Oct 26 01:06:35.28: [ 9168]: <-- data [1026]
Oct 26 01:06:37.28: [ 9168]: <-- data [1028]
Oct 26 01:06:37.28: [ 9168]: <-- data [1031]
Oct 26 01:06:37.28: [ 9168]: <-- data [1024]
Oct 26 01:06:37.28: [ 9168]: <-- data [1024]
Oct 26 01:06:39.28: [ 9168]: <-- data [1024]
Oct 26 01:06:39.28: [ 9168]: <-- data [1024]
Oct 26 01:06:39.28: [ 9168]: <-- data [1024]
Oct 26 01:06:39.28: [ 9168]: <-- data [1024]
Oct 26 01:06:41.28: [ 9168]: <-- data [1024]
Oct 26 01:06:41.28: [ 9168]: <-- data [1024]
Oct 26 01:06:41.28: [ 9168]: <-- data [1024]
Oct 26 01:06:41.28: [ 9168]: <-- data [1024]
Oct 26 01:06:41.87: [ 9168]: <-- data [1024]
Oct 26 01:06:42.95: [ 9168]: <-- data [1024]
Oct 26 01:06:42.95: [ 9168]: <-- data [1024]
Oct 26 01:06:44.03: [ 9168]: <-- data [1024]
Oct 26 01:06:45.12: [ 9168]: <-- data [1024]
Oct 26 01:06:45.12: [ 9168]: <-- data [1024]
Oct 26 01:06:46.24: [ 9168]: <-- data [905]
Oct 26 01:06:46.24: [ 9168]: SENT 38793 bytes of data
Oct 26 01:06:46.24: [ 9168]: <-- data [1024]
Oct 26 01:06:47.33: [ 9168]: <-- data [1024]
Oct 26 01:06:47.33: [ 9168]: <-- data [1024]
Oct 26 01:06:48.44: [ 9168]: <-- data [1024]
Oct 26 01:06:48.44: [ 9168]: <-- data [1024]
Oct 26 01:06:49.52: [ 9168]: <-- data [1024]
Oct 26 01:06:49.52: [ 9168]: <-- data [1026]
Oct 26 01:06:50.60: [ 9168]: <-- data [1030]
Oct 26 01:06:50.60: [ 9168]: <-- data [1028]
Oct 26 01:06:51.69: [ 9168]: <-- data [1028]
Oct 26 01:06:51.69: [ 9168]: <-- data [1027]
Oct 26 01:06:52.81: [ 9168]: <-- data [1030]
Oct 26 01:06:52.81: [ 9168]: <-- data [1025]
Oct 26 01:06:53.98: [ 9168]: <-- data [1029]
Oct 26 01:06:53.98: [ 9168]: <-- data [1029]
Oct 26 01:06:55.25: [ 9168]: <-- data [657]
Oct 26 01:06:55.25: [ 9168]: SENT 16016 bytes of data
Oct 26 01:06:55.25: [ 9168]: SEND 2D RTC
Oct 26 01:06:55.25: [ 9168]: <-- data [30]
Oct 26 01:06:55.25: [ 9168]: <-- data [2]
Oct 26 01:06:55.25: [ 9168]: SEND end page
Oct 26 01:06:58.14: [ 9168]: --> [2:OK]
Oct 26 01:06:58.14: [ 9168]: <-- [9:AT+FTS=9\r]
Oct 26 01:06:58.23: [ 9168]: --> [2:OK]
Oct 26 01:06:58.23: [ 9168]: SEND send EOP (no more pages or documents)
Oct 26 01:06:58.23: [ 9168]: <-- [9:AT+FTH=3\r]
Oct 26 01:06:59.20: [ 9168]: --> [7:CONNECT]
Oct 26 01:06:59.20: [ 9168]: <-- HDLC<3:FF C8 F4>
Oct 26 01:06:59.20: [ 9168]: <-- data [3]
Oct 26 01:06:59.20: [ 9168]: <-- data [2]
Oct 26 01:06:59.69: [ 9168]: --> [2:OK]
Oct 26 01:06:59.69: [ 9168]: <-- [9:AT+FRH=3\r]
Oct 26 01:07:02.79: [ 9168]: --> [0:]
Oct 26 01:07:02.79: [ 9168]: MODEM <Empty line>
Oct 26 01:07:02.79: [ 9168]: MODEM TIMEOUT: waiting for v.21 carrier
Oct 26 01:07:02.79: [ 9168]: <-- data [1]
Oct 26 01:07:02.80: [ 9168]: --> [2:]
Oct 26 01:07:02.80: [ 9168]: --> [2:OK]
Oct 26 01:07:02.80: [ 9168]: SEND send EOP (no more pages or documents)
Oct 26 01:07:02.80: [ 9168]: <-- [9:AT+FTH=3\r]
Oct 26 01:07:03.77: [ 9168]: --> [7:CONNECT]
Oct 26 01:07:03.77: [ 9168]: <-- HDLC<3:FF C8 F4>
Oct 26 01:07:03.77: [ 9168]: <-- data [3]
Oct 26 01:07:03.77: [ 9168]: <-- data [2]
Oct 26 01:07:04.27: [ 9168]: --> [2:OK]
Oct 26 01:07:04.27: [ 9168]: <-- [9:AT+FRH=3\r]
Oct 26 01:07:07.37: [ 9168]: --> [0:]
Oct 26 01:07:07.37: [ 9168]: MODEM <Empty line>
Oct 26 01:07:07.37: [ 9168]: MODEM TIMEOUT: waiting for v.21 carrier
Oct 26 01:07:07.37: [ 9168]: <-- data [1]
Oct 26 01:07:07.38: [ 9168]: --> [2:]
Oct 26 01:07:07.38: [ 9168]: --> [2:OK]
Oct 26 01:07:07.38: [ 9168]: SEND send EOP (no more pages or documents)
Oct 26 01:07:07.38: [ 9168]: <-- [9:AT+FTH=3\r]
Oct 26 01:07:08.35: [ 9168]: --> [7:CONNECT]
Oct 26 01:07:08.35: [ 9168]: <-- HDLC<3:FF C8 F4>
Oct 26 01:07:08.35: [ 9168]: <-- data [3]
Oct 26 01:07:08.35: [ 9168]: <-- data [2]
Oct 26 01:07:08.84: [ 9168]: --> [2:OK]
Oct 26 01:07:08.84: [ 9168]: <-- [9:AT+FRH=3\r]
Oct 26 01:07:11.96: [ 9168]: --> [0:]
Oct 26 01:07:11.96: [ 9168]: MODEM <Empty line>
Oct 26 01:07:11.96: [ 9168]: MODEM TIMEOUT: waiting for v.21 carrier
Oct 26 01:07:11.96: [ 9168]: <-- data [1]
Oct 26 01:07:11.97: [ 9168]: --> [2:]
Oct 26 01:07:11.97: [ 9168]: --> [2:OK]
Oct 26 01:07:11.97: [ 9168]: No response to MPS or EOP repeated 3 tries
Oct 26 01:07:11.98: [ 9168]: <-- [9:AT+FTH=3\r]
Oct 26 01:07:12.95: [ 9168]: --> [7:CONNECT]
Oct 26 01:07:12.95: [ 9168]: <-- HDLC<3:FF C8 DF>
Oct 26 01:07:12.95: [ 9168]: <-- data [3]
Oct 26 01:07:12.95: [ 9168]: <-- data [2]
Oct 26 01:07:13.44: [ 9168]: --> [2:OK]
Oct 26 01:07:13.44: [ 9168]: MODEM input buffering enabled
Oct 26 01:07:13.44: [ 9168]: <-- [5:ATH0\r]
Oct 26 01:07:13.60: [ 9168]: --> [2:OK]
Oct 26 01:07:13.60: [ 9168]: MODEM set DTR OFF
Oct 26 01:07:13.60: [ 9168]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Oct 26 01:07:13.60: [ 9168]: SESSION END