HylaFAX The world's most advanced open source fax server

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

[hylafax-users] receive failure



Hi list,

we run hylafax 4.2.1 (debian sarge).
we switched to Multitech MT5634ba(USB) modems.
sending is quite fine.
receiving results in an error about every 10th fax.
modem ist configured as class1.
as I am not so familiar with the fax-protocol,
I would like to know if this is a modem problem,
a line problem or a problem on the other end.

any hint appreciated

TIA
Matthias

a receive-log (others are quite the same) follows:

    Failed to properly detect high-speed data carrier.

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

Apr 04 10:40:35.93: [12667]: SESSION BEGIN 000418060 49711XXXXXXXXX
Apr 04 10:40:35.93: [12667]: HylaFAX (tm) Version 4.2.1
Apr 04 10:40:35.93: [12667]: <-- [4:ATA\r]
Apr 04 10:40:45.55: [12667]: --> [7:CONNECT]
Apr 04 10:40:45.55: [12667]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyACM2'
Apr 04 10:40:45.55: [12667]: MODEM input buffering enabled
Apr 04 10:40:45.55: [12667]: RECV FAX: begin
Apr 04 10:40:45.55: [12667]: MODEM input buffering disabled
Apr 04 10:40:45.55: [12667]: <-- HDLC<32:FF C0 04 AD 00 55 12 9E 36 86 62 82 
1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 4C 74 8C>
Apr 04 10:40:45.56: [12667]: --> [7:CONNECT]
Apr 04 10:40:45.56: [12667]: <-- HDLC<23:FF C0 02 2E 4E 86 E6 2E 2E AE 2E CA 
04 E2 A6 04 CA F2 E2 82 12 04 04>
Apr 04 10:40:45.56: [12667]: --> [7:CONNECT]
Apr 04 10:40:45.56: [12667]: <-- HDLC<10:FF C8 01 00 76 5F 23 01 FB C0>
Apr 04 10:40:47.86: [12667]: --> [2:OK]
Apr 04 10:40:47.86: [12667]: <-- [9:AT+FRH=3\r]
Apr 04 10:40:48.00: [12667]: --> [7:CONNECT]
Apr 04 10:40:49.62: [12667]: --> HDLC<25:FF C0 C2 2C 8C 04 8C 2C 2C 9C 04 4C 
4C 2C AC 04 9C 2C D4 04 04 04 04 62 78>
Apr 04 10:40:49.62: [12667]: --> [2:OK]
Apr 04 10:40:49.62: [12667]: REMOTE TSI "+49 542XXXXXXXXX"
Apr 04 10:40:49.62: [12667]: <-- [9:AT+FRH=3\r]
Apr 04 10:40:49.63: [12667]: --> [7:CONNECT]
Apr 04 10:40:49.90: [12667]: --> HDLC<9:FF C8 C1 00 46 1F 22 39 BB>
Apr 04 10:40:49.90: [12667]: --> [2:OK]
Apr 04 10:40:49.90: [12667]: REMOTE wants 14400 bit/s
Apr 04 10:40:49.90: [12667]: REMOTE wants A4 page width (215 mm)
Apr 04 10:40:49.90: [12667]: REMOTE wants unlimited page length
Apr 04 10:40:49.90: [12667]: REMOTE wants 7.7 line/mm
Apr 04 10:40:49.90: [12667]: REMOTE wants 2-D MMR
Apr 04 10:40:49.90: [12667]: REMOTE wants T.30 Annex A, 256-byte ECM
Apr 04 10:40:49.90: [12667]: RECV training at v.17 14400 bit/s
Apr 04 10:40:49.90: [12667]: <-- [11:AT+FRM=145\r]
Apr 04 10:40:51.43: [12667]: --> [7:CONNECT]
Apr 04 10:40:52.79: [12667]: RECV: TCF 2448 bytes, 0% non-zero, 2448 zero-run
Apr 04 10:40:52.79: [12667]: --> [10:NO CARRIER]
Apr 04 10:40:52.79: [12667]: DELAY 75 ms
Apr 04 10:40:52.87: [12667]: TRAINING succeeded
Apr 04 10:40:52.87: [12667]: <-- [9:AT+FTH=3\r]
Apr 04 10:40:53.82: [12667]: --> [7:CONNECT]
Apr 04 10:40:53.82: [12667]: <-- HDLC<3:FF C8 21>
Apr 04 10:40:54.32: [12667]: --> [2:OK]
Apr 04 10:40:54.32: [12667]: MODEM input buffering enabled
Apr 04 10:40:54.32: [12667]: <-- [11:AT+FRM=146\r]
Apr 04 10:40:54.68: [12667]: --> [7:CONNECT]
Apr 04 10:40:54.96: [12667]: --> HDLC<262:FF C0 60 00 93 50 32 86 E5 36 6A 1B 
93 50 32 86 E5 8A 29 35 02 A8 2C A2 05 06 A2 5C 32 01 E4 D4 16 C1 82 38 19 86 
D9 1C 0D 32 38 64 04 23 86 48 35 11 C0 F0 5A 23 86 24 32 59 A9 4A 0C 90 D8 8A 
C4 8A C4 8A C4 8A C4 8A C4 8A AC 81 E0 5E 08 29 92 93 50 5A 89 CD 85 44 E6 C9 
42 79 40 9D 75 62 7D 92 90 5D D0 23 0E 40 F0 6C 35 29 5C AC CA CC AC CA CC AC 
CA AD 20 41 32 38 32 C9 A8 2D 47 1C 71 C7 20 BB 90 5A E2 1F BA 08 2C 81 E1 AE 
6A 52 B3 3C BE 5E 23 F2 B2 6B 09 2B 26 02 4A C9 80 49 59 95 93 C2 4A AC 8A 8F 
EF 20 CA 4A 4D 41 6B A0 8A 1C 20 85 47 2A 6E 39 53 71 CA 43 8C D8 39 1C 12 3E 
41 77 83 FE 82 0B 20 78 6B 9A 94 AD 25 6C 8F CA CF 72 B3 DC AC FC AC CA 21 92 
39 59 E5 57 7E D3 44 14 89 49 A8 2D 74 11 43 84 10 A8 CC 5C 22 3F 1F 08 8F 9D 
28 FE 3F E3 E4 17 7B F6 88 1E 0D A6 A5 2B 09 84>
Apr 04 10:40:54.96: [12667]: RECV received frame number 0
...
receiving frames 0 to 81 properly
...
Apr 04 10:41:07.40: [12667]: --> HDLC<262:FF C0 60 4A B0 7A C9 F4 C2 5C DD FB 
E0 DC C7 C3 FF BF FD CC 7B AD EA EB 77 F8 5E E0 FE 35 E2 E3 D5 30 9C 69 A6 DC 
54 54 6C 69 A6 B7 F7 0E 35 5E 87 1B 0D 8A 5D 93 B6 AC 76 9C 54 18 4D 8A 43 58 
AB 61 84 D8 82 23 FA CF 0E 18 88 88 88 88 88 8A 3D C4 44 44 46 55 C4 45 1E E2 
22 39 44 05 2A 21 84 22 30 40 E2 22 18 42 22 22 22 22 22 23 58 FA FF 11 48 38 
88 8A BF FF ED 74 A2 98 A8 AD AB 1B 54 D4 30 C4 44 63 FF FF FF FF F9 4D 51 4A 
61 2D 19 E7 06 47 8C 03 24 B5 3D 11 AC DA 2E 8E 44 76 47 8B E5 E3 11 1C 53 08 
8E 0B 61 96 55 02 88 88 8C B4 17 46 F3 C8 D1 1D 11 F4 44 22 1A 3C C8 EC F2 23 
A2 38 67 23 E5 CC BB 23 83 51 1C C8 E1 92 06 13 08 44 47 42 22 24 8C 11 66 C9 
C9 A8 28 30 CB 83 69 3E 61 11 E3 8C 8E 19 01 9A 76 91 17 0D 05 73 E4 7C 44 44 
44 44 5B 88 9F 62 08 9B 34 22 B3 49 CB D9 20 E5>
Apr 04 10:41:07.40: [12667]: RECV received frame number 82
Apr 04 10:41:07.40: [12667]: --> HDLC<56:FF C0 60 CA 31 29 B9 AC EC 4C C4 4F 
C2 22 3B 23 A3 B1 B0 E5 B8 F8 9E 45 F1 C5 88 88 E1 1B 47 6B 07 82 11 D4 7E 4D 
7F FF FE 3F FF FF FF FF FF FF FF F0 01 00 10 00 66 1D>
Apr 04 10:41:07.40: [12667]: Bad HDLC terminating flag received.
Apr 04 10:41:07.40: [12667]: RECV assumed RCP frame with block end
Apr 04 10:41:07.40: [12667]: --> [10:NO CARRIER]
Apr 04 10:41:07.40: [12667]: MODEM input buffering disabled
Apr 04 10:41:07.40: [12667]: <-- [9:AT+FRH=3\r]
Apr 04 10:41:07.49: [12667]: --> [7:CONNECT]
Apr 04 10:41:08.70: [12667]: --> HDLC<9:FF C8 FD F4 00 00 CA 2B A4>
Apr 04 10:41:08.70: [12667]: --> [2:OK]
Apr 04 10:41:08.70: [12667]: RECV recv PPS (partial page signal)
Apr 04 10:41:08.70: [12667]: RECV recv EOP (no more pages or documents)
Apr 04 10:41:08.70: [12667]: RECV received 84 frames of block 1 of page 1
Apr 04 10:41:08.70: [12667]: DELAY 70 ms
Apr 04 10:41:08.77: [12667]: <-- [9:AT+FTH=3\r]
Apr 04 10:41:09.72: [12667]: --> [7:CONNECT]
Apr 04 10:41:09.72: [12667]: <-- HDLC<35:FF C8 3D 00 00 00 00 00 00 00 00 00 
00 1F FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF>
Apr 04 10:41:11.18: [12667]: --> [2:OK]
Apr 04 10:41:11.18: [12667]: RECV send PPR (partial page request)
Apr 04 10:41:11.18: [12667]: MODEM input buffering enabled
Apr 04 10:41:11.18: [12667]: <-- [11:AT+FRM=146\r]
Apr 04 10:41:11.54: [12667]: --> [7:CONNECT]
Apr 04 10:41:11.68: [12667]: --> HDLC<56:FF C0 60 CA 31 29 B9 AC EC 4C C4 4F 
C2 22 3B 23 A3 B1 B0 E5 B8 F8 9E 45 F1 C5 88 88 E1 1B 47 6B 07 82 11 D4 7E 4D 
7F FF FE 3F FF FF FF FF FF FF FF F0 01 00 10 00 66 1D>
Apr 04 10:41:11.68: [12667]: Bad HDLC terminating flag received.
Apr 04 10:41:11.68: [12667]: RECV assumed RCP frame with block end
Apr 04 10:41:11.68: [12667]: --> [10:NO CARRIER]
Apr 04 10:41:11.68: [12667]: MODEM input buffering disabled
Apr 04 10:41:11.68: [12667]: <-- [9:AT+FRH=3\r]
Apr 04 10:41:11.77: [12667]: --> [7:CONNECT]
Apr 04 10:41:12.97: [12667]: --> HDLC<9:FF C8 FD F4 00 00 00 53 A2>
Apr 04 10:41:12.97: [12667]: --> [2:OK]
Apr 04 10:41:12.97: [12667]: RECV recv PPS (partial page signal)
Apr 04 10:41:12.97: [12667]: RECV recv EOP (no more pages or documents)
Apr 04 10:41:12.97: [12667]: RECV received 1 frames of block 1 of page 1
Apr 04 10:41:12.97: [12667]: DELAY 70 ms
Apr 04 10:41:13.04: [12667]: <-- [9:AT+FTH=3\r]
Apr 04 10:41:14.00: [12667]: --> [7:CONNECT]
Apr 04 10:41:14.00: [12667]: <-- HDLC<35:FF C8 3D 00 00 00 00 00 00 00 00 00 
00 1F FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF>
Apr 04 10:41:15.46: [12667]: --> [2:OK]
Apr 04 10:41:15.46: [12667]: RECV send PPR (partial page request)
Apr 04 10:41:15.46: [12667]: MODEM input buffering enabled
Apr 04 10:41:15.46: [12667]: <-- [11:AT+FRM=146\r]
Apr 04 10:41:15.81: [12667]: --> [7:CONNECT]
Apr 04 10:41:15.95: [12667]: RECV assumed RCP frame with block end
Apr 04 10:41:15.95: [12667]: --> [10:NO CARRIER]
Apr 04 10:41:15.95: [12667]: MODEM input buffering disabled
Apr 04 10:41:15.95: [12667]: <-- [9:AT+FRH=3\r]
Apr 04 10:41:16.04: [12667]: --> [7:CONNECT]
Apr 04 10:41:17.24: [12667]: --> HDLC<9:FF C8 FD F4 00 00 00 53 A2>
Apr 04 10:41:17.24: [12667]: --> [2:OK]
Apr 04 10:41:17.24: [12667]: RECV recv PPS (partial page signal)
Apr 04 10:41:17.24: [12667]: RECV recv EOP (no more pages or documents)
Apr 04 10:41:17.24: [12667]: RECV received 1 frames of block 1 of page 1
Apr 04 10:41:17.24: [12667]: DELAY 70 ms
Apr 04 10:41:17.32: [12667]: <-- [9:AT+FTH=3\r]
Apr 04 10:41:18.27: [12667]: --> [7:CONNECT]
Apr 04 10:41:18.27: [12667]: <-- HDLC<35:FF C8 3D 00 00 00 00 00 00 00 00 00 
00 1F FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF>
Apr 04 10:41:19.73: [12667]: --> [2:OK]
Apr 04 10:41:19.73: [12667]: RECV send PPR (partial page request)
Apr 04 10:41:19.73: [12667]: MODEM input buffering enabled
Apr 04 10:41:19.73: [12667]: <-- [11:AT+FRM=146\r]
Apr 04 10:41:20.09: [12667]: --> [7:CONNECT]
Apr 04 10:41:20.22: [12667]: --> HDLC<56:FF C0 60 CA 31 29 B9 AC EC 4C C4 4F 
C2 22 3B 23 A3 B1 B0 E5 B8 F8 9E 45 F1 C5 88 88 E1 1B 47 6B 07 82 11 D4 7E 4D 
7F FF FE 3F FF FF FF FF FF FF FF F0 01 00 10 00 66 1D>
Apr 04 10:41:20.22: [12667]: Bad HDLC terminating flag received.
Apr 04 10:41:20.22: [12667]: RECV assumed RCP frame with block end
Apr 04 10:41:20.22: [12667]: --> [10:NO CARRIER]
Apr 04 10:41:20.22: [12667]: MODEM input buffering disabled
Apr 04 10:41:20.22: [12667]: <-- [9:AT+FRH=3\r]
Apr 04 10:41:20.31: [12667]: --> [7:CONNECT]
Apr 04 10:41:21.52: [12667]: --> HDLC<9:FF C8 FD F4 00 00 00 53 A2>
Apr 04 10:41:21.52: [12667]: --> [2:OK]
Apr 04 10:41:21.52: [12667]: RECV recv PPS (partial page signal)
Apr 04 10:41:21.52: [12667]: RECV recv EOP (no more pages or documents)
Apr 04 10:41:21.52: [12667]: RECV received 1 frames of block 1 of page 1
Apr 04 10:41:21.52: [12667]: DELAY 70 ms
Apr 04 10:41:21.59: [12667]: <-- [9:AT+FTH=3\r]
Apr 04 10:41:22.54: [12667]: --> [7:CONNECT]
Apr 04 10:41:22.54: [12667]: <-- HDLC<35:FF C8 3D 00 00 00 00 00 00 00 00 00 
00 1F FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF>
Apr 04 10:41:24.00: [12667]: --> [2:OK]
Apr 04 10:41:24.00: [12667]: RECV send PPR (partial page request)
Apr 04 10:41:24.00: [12667]: RECV sent fourth PPR
Apr 04 10:41:24.00: [12667]: <-- [9:AT+FRH=3\r]
Apr 04 10:41:24.14: [12667]: --> [7:CONNECT]
Apr 04 10:41:25.28: [12667]: --> HDLC<7:FF C8 C8 00 04 4D E9>
Apr 04 10:41:25.28: [12667]: --> [2:OK]
Apr 04 10:41:25.28: [12667]: RECV recv CTC (continue to correct)
Apr 04 10:41:25.28: [12667]: DELAY 70 ms
Apr 04 10:41:25.35: [12667]: <-- [9:AT+FTH=3\r]
Apr 04 10:41:26.30: [12667]: --> [7:CONNECT]
Apr 04 10:41:26.30: [12667]: <-- HDLC<3:FF C8 23>
Apr 04 10:41:26.80: [12667]: --> [2:OK]
Apr 04 10:41:26.80: [12667]: RECV send CTR (confirm continue to correct)
Apr 04 10:41:26.80: [12667]: MODEM input buffering enabled
Apr 04 10:41:26.80: [12667]: <-- [11:AT+FRM=145\r]
Apr 04 10:41:33.80: [12667]: MODEM TIMEOUT: reading line from modem
Apr 04 10:41:33.80: [12667]: RECV keeping unconfirmed page
Apr 04 10:41:33.88: [12667]: RECV: 21504 bytes of data, 2302 total lines
Apr 04 10:41:34.08: [12667]: MODEM TIMEOUT: reading line from modem
Apr 04 10:41:34.08: [12667]: MODEM <Timeout>
Apr 04 10:41:34.08: [12667]: MODEM input buffering disabled
Apr 04 10:41:34.08: [12667]: DELAY 70 ms
Apr 04 10:41:34.15: [12667]: RECV FAX (000418060): from +49 5422 9441 14, page 
1 in 0:42, INF, 7.7 line/mm, 2-D MMR, 14400 bit/s
Apr 04 10:41:34.16: [12667]: RECV FAX (000418060): recvq/fax000088069.tif from 
+49 5422 9441 14, route to <unspecified>, 1 pages in 0:49
Apr 04 10:41:34.16: [12667]: RECV FAX: Failed to properly detect high-speed 
data carrier.
Apr 04 10:41:34.16: [12667]: <-- [9:AT+FTH=3\r]
Apr 04 10:41:35.11: [12667]: --> [7:CONNECT]
Apr 04 10:41:35.11: [12667]: <-- HDLC<3:FF C8 5F>
Apr 04 10:41:35.61: [12667]: --> [2:OK]
Apr 04 10:41:35.61: [12667]: MODEM input buffering enabled
Apr 04 10:41:35.61: [12667]: RECV FAX (000418060): session with +49 XXXXXXXX 
terminated abnormally: Failed to properly detect high-speed data carrier.
Apr 04 10:41:35.61: [12667]: RECV FAX: bin/faxrcvd.hagos 
"recvq/fax000088069.tif" "ttyACM2" "000418060" "Failed to properly detect 
high-speed data carrier." "" ""
Apr 04 10:41:35.61: [12667]: RECV FAX: end
Apr 04 10:41:35.61: [12667]: SESSION END
-- 
HAGOS eG                 phone: +49 711 7880592
Matthias Reich             fax: +49 711 7880535
Industriestr. 62           web: http://www.hagos.de
D-70565 Stuttgart         mail: rei@xxxxxxxx
Germany

Attachment: pgp00001.pgp
Description: PGP signature




Project hosted by iFAX Solutions