Re: [hylafax-users] Failed to properly detect high-speed datacarrier

[Davide Pagnin <pagnin@xxxxxxxxxxxxxx>]

	Hi Ralph,

We are using hylafax+ 5.2.8, but for this purpose I think hylafax 4.4.4
is equivalent.

We have the same error message.

We have a Multitech MT9234ZBA-USB modem.

This is the log of one of the session:

Jan 26 12:00:08.47: [21838]: SESSION BEGIN 000000489 +390438XXXXXX
Jan 26 12:00:08.47: [21838]: HylaFAX (tm) Version 5.2.7
Jan 26 12:00:08.47: [21838]: <-- [4:ATA\r]
Jan 26 12:00:19.60: [21838]: --> [7:CONNECT]
Jan 26 12:00:19.60: [21838]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyUSB0'
Jan 26 12:00:19.60: [21838]: STATE CHANGE: ANSWERING -> RECEIVING
Jan 26 12:00:19.60: [21838]: RECV FAX: begin
Jan 26 12:00:19.60: [21838]: <-- HDLC<32:FF C0 04 B5 00 AA 12 9E 36 86
62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 AC 74 4C 74 EC>
Jan 26 12:00:19.60: [21838]: <-- data [32]
Jan 26 12:00:19.60: [21838]: <-- data [2]
Jan 26 12:00:19.63: [21838]: --> [7:CONNECT]
Jan 26 12:00:19.63: [21838]: <-- HDLC<23:FF C0 02 82 0E CA 04 B2 CA C2
04 04 04 04 04 04 04 04 04 04 04 04 04>
Jan 26 12:00:19.63: [21838]: <-- data [23]
Jan 26 12:00:19.63: [21838]: <-- data [2]
Jan 26 12:00:19.66: [21838]: --> [7:CONNECT]
Jan 26 12:00:19.66: [21838]: <-- HDLC<13:FF C8 01 00 73 5F 23 01 FB C1
01 01 18>
Jan 26 12:00:19.66: [21838]: <-- data [13]
Jan 26 12:00:19.66: [21838]: <-- data [2]
Jan 26 12:00:21.93: [21838]: --> [2:OK]
Jan 26 12:00:21.93: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:00:22.99: [21838]: --> [7:CONNECT]
Jan 26 12:00:24.73: [21838]: --> HDLC<25:FF C0 C2 AC EC 1C 6C 2C 1C 6C
4C 1C 4C 0C 9C 04 04 04 04 04 04 04 04 9C A6>
Jan 26 12:00:24.73: [21838]: --> [2:OK]
Jan 26 12:00:24.73: [21838]: RECV recv TSI (sender id)
Jan 26 12:00:24.73: [21838]: REMOTE TSI "XXXXXXXXXXXX"
Jan 26 12:00:24.73: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:00:24.75: [21838]: --> [7:CONNECT]
Jan 26 12:00:25.05: [21838]: --> HDLC<9:FF C8 C1 00 60 0F 22 0E AE>
Jan 26 12:00:25.05: [21838]: --> [2:OK]
Jan 26 12:00:25.05: [21838]: RECV recv DCS (command signal)
Jan 26 12:00:25.05: [21838]: REMOTE wants 9600 bit/s
Jan 26 12:00:25.05: [21838]: REMOTE wants A4 page width (215 mm)
Jan 26 12:00:25.05: [21838]: REMOTE wants A4 page length (297 mm)
Jan 26 12:00:25.05: [21838]: REMOTE wants 3.85 line/mm
Jan 26 12:00:25.05: [21838]: REMOTE wants 2-D MMR
Jan 26 12:00:25.05: [21838]: REMOTE wants T.30 Annex A, 256-byte ECM
Jan 26 12:00:25.05: [21838]: RECV training at v.29 9600 bit/s
Jan 26 12:00:25.05: [21838]: <-- [10:AT+FRM=96\r]
Jan 26 12:00:25.43: [21838]: --> [7:CONNECT]
Jan 26 12:00:27.05: [21838]: RECV: TCF 1936 bytes, 2% non-zero, 1862
zero-run
Jan 26 12:00:27.05: [21838]: --> [10:NO CARRIER]
Jan 26 12:00:27.05: [21838]: <-- [9:AT+FRS=7\r]
Jan 26 12:00:27.14: [21838]: --> [2:OK]
Jan 26 12:00:27.14: [21838]: TRAINING succeeded
Jan 26 12:00:27.14: [21838]: <-- [9:AT+FTH=3\r]
Jan 26 12:00:28.11: [21838]: --> [7:CONNECT]
Jan 26 12:00:28.11: [21838]: <-- HDLC<3:FF C8 21>
Jan 26 12:00:28.11: [21838]: <-- data [3]
Jan 26 12:00:28.11: [21838]: <-- data [2]
Jan 26 12:00:28.50: [21838]: --> [2:OK]
Jan 26 12:00:28.50: [21838]: <-- [10:AT+FRM=96\r]
Jan 26 12:00:29.62: [21838]: --> [7:CONNECT]
Jan 26 12:00:29.62: [21838]: MODEM input buffering enabled
Jan 26 12:00:30.16: [21838]: RECV received frame number 0
Jan 26 12:00:30.37: [21838]: RECV received frame number 1
Jan 26 12:00:30.69: [21838]: RECV received frame number 2
Jan 26 12:00:30.90: [21838]: RECV received frame number 3
Jan 26 12:00:31.12: [21838]: RECV received frame number 4
Jan 26 12:00:31.33: [21838]: RECV received frame number 5
Jan 26 12:00:31.54: [21838]: RECV received frame number 6
Jan 26 12:00:31.76: [21838]: RECV received frame number 7
Jan 26 12:00:32.08: [21838]: RECV received frame number 8
Jan 26 12:00:32.29: [21838]: RECV received frame number 9
Jan 26 12:00:32.50: [21838]: RECV received frame number 10
Jan 26 12:00:32.72: [21838]: RECV received frame number 11
Jan 26 12:00:32.93: [21838]: RECV received frame number 12
Jan 26 12:00:33.14: [21838]: RECV received frame number 13
Jan 26 12:00:33.36: [21838]: RECV received frame number 14
Jan 26 12:00:33.68: [21838]: RECV received frame number 15
Jan 26 12:00:33.89: [21838]: RECV received frame number 16
Jan 26 12:00:34.10: [21838]: RECV received frame number 17
Jan 26 12:00:34.32: [21838]: RECV received frame number 18
Jan 26 12:00:34.53: [21838]: RECV received frame number 19
Jan 26 12:00:34.74: [21838]: RECV received frame number 20
Jan 26 12:00:35.06: [21838]: RECV received frame number 21
Jan 26 12:00:35.28: [21838]: RECV received frame number 22
Jan 26 12:00:35.49: [21838]: RECV received frame number 23
Jan 26 12:00:35.70: [21838]: RECV received frame number 24
Jan 26 12:00:35.92: [21838]: RECV received frame number 25
Jan 26 12:00:36.13: [21838]: RECV received frame number 26
Jan 26 12:00:36.34: [21838]: RECV received frame number 27
Jan 26 12:00:36.66: [21838]: RECV received frame number 28
Jan 26 12:00:36.88: [21838]: RECV received frame number 29
Jan 26 12:00:37.09: [21838]: RECV received frame number 30
Jan 26 12:00:37.30: [21838]: RECV received frame number 31
Jan 26 12:00:37.30: [21838]: RECV frame FCS check failed
Jan 26 12:00:37.30: [21838]: HDLC frame not byte-oriented.  Trailing
byte: 0xfc
Jan 26 12:00:37.52: [21838]: RECV received frame number 32
Jan 26 12:00:37.74: [21838]: RECV received frame number 33
Jan 26 12:00:37.96: [21838]: RECV received frame number 34
Jan 26 12:00:38.28: [21838]: RECV received frame number 35
Jan 26 12:00:38.49: [21838]: RECV received frame number 36
Jan 26 12:00:38.70: [21838]: RECV received frame number 37
Jan 26 12:00:38.92: [21838]: RECV received frame number 38
Jan 26 12:00:39.13: [21838]: RECV received frame number 39
Jan 26 12:00:39.34: [21838]: RECV received frame number 40
Jan 26 12:00:39.66: [21838]: RECV received frame number 41
Jan 26 12:00:39.88: [21838]: RECV received frame number 42
Jan 26 12:00:40.09: [21838]: RECV received frame number 43
Jan 26 12:00:40.30: [21838]: RECV received frame number 44
Jan 26 12:00:40.52: [21838]: RECV received frame number 45
Jan 26 12:00:40.73: [21838]: RECV received frame number 46
Jan 26 12:00:40.94: [21838]: RECV received frame number 47
Jan 26 12:00:40.94: [21838]: RECV frame FCS check failed
Jan 26 12:00:40.94: [21838]: HDLC frame not byte-oriented.  Trailing
byte: 0xfc
Jan 26 12:00:41.26: [21838]: RECV received frame number 48
Jan 26 12:00:41.48: [21838]: RECV received frame number 49
Jan 26 12:00:41.69: [21838]: RECV received frame number 50
Jan 26 12:00:41.90: [21838]: RECV received frame number 51
Jan 26 12:00:42.12: [21838]: RECV received frame number 52
Jan 26 12:00:42.33: [21838]: RECV received frame number 53
Jan 26 12:00:42.72: [21838]: RECV received frame number 54
Jan 26 12:00:42.72: [21838]: RECV received RCP frame
Jan 26 12:00:42.72: [21838]: MODEM input buffering disabled
Jan 26 12:00:42.72: [21838]: --> [10:NO CARRIER]
Jan 26 12:00:42.72: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:00:42.80: [21838]: --> [7:CONNECT]
Jan 26 12:00:43.93: [21838]: --> HDLC<9:FF C8 FD F4 00 00 6C FE 88>
Jan 26 12:00:43.93: [21838]: --> [2:OK]
Jan 26 12:00:43.93: [21838]: RECV recv PPS (partial page signal)
Jan 26 12:00:43.93: [21838]: RECV recv EOP (no more pages or documents)
Jan 26 12:00:43.93: [21838]: RECV received 55 frames of block 1 of page 1
Jan 26 12:00:43.93: [21838]: <-- [9:AT+FRS=7\r]
Jan 26 12:00:44.02: [21838]: --> [2:OK]
Jan 26 12:00:44.02: [21838]: <-- [9:AT+FTH=3\r]
Jan 26 12:00:44.98: [21838]: --> [7:CONNECT]
Jan 26 12:00:44.98: [21838]: <-- HDLC<35:FF C8 3D 00 00 00 01 00 01 01
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF>
Jan 26 12:00:44.98: [21838]: <-- data [35]
Jan 26 12:00:44.98: [21838]: <-- data [2]
Jan 26 12:00:46.38: [21838]: --> [2:OK]
Jan 26 12:00:46.38: [21838]: RECV send PPR (partial page request)
Jan 26 12:00:46.38: [21838]: <-- [10:AT+FRM=96\r]
Jan 26 12:00:47.57: [21838]: --> [8:+FCERROR]
Jan 26 12:00:47.57: [21838]: <-- [10:AT+FRM=96\r]
Jan 26 12:00:48.28: [21838]: --> [8:+FCERROR]
Jan 26 12:00:48.28: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:00:48.35: [21838]: --> [7:CONNECT]
Jan 26 12:00:49.31: [21838]: --> [2:10 03]
Jan 26 12:00:49.31: [21838]: --> [10:NO CARRIER]
Jan 26 12:00:49.31: [21838]: MODEM No carrier
Jan 26 12:00:49.31: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:00:50.97: [21838]: --> [7:CONNECT]
Jan 26 12:00:53.46: [21838]: --> HDLC<5:FF C8 D8 29 88>
Jan 26 12:00:53.46: [21838]: --> [2:OK]
Jan 26 12:00:53.46: [21838]: RECV recv CRP (command repeat)
Jan 26 12:00:53.46: [21838]: <-- [9:AT+FRS=7\r]
Jan 26 12:00:53.59: [21838]: --> [2:OK]
Jan 26 12:00:53.59: [21838]: <-- [9:AT+FTH=3\r]
Jan 26 12:00:54.57: [21838]: --> [7:CONNECT]
Jan 26 12:00:54.57: [21838]: <-- HDLC<35:FF C8 3D 00 00 00 01 00 01 01
FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF>
Jan 26 12:00:54.57: [21838]: <-- data [35]
Jan 26 12:00:54.57: [21838]: <-- data [2]
Jan 26 12:00:55.96: [21838]: --> [2:OK]
Jan 26 12:00:55.96: [21838]: RECV send PPR (partial page request)
Jan 26 12:00:55.96: [21838]: <-- [10:AT+FRM=96\r]
Jan 26 12:01:01.01: [21838]: --> [8:+FCERROR]
Jan 26 12:01:01.01: [21838]: <-- [10:AT+FRM=96\r]
Jan 26 12:01:01.71: [21838]: --> [8:+FCERROR]
Jan 26 12:01:01.71: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:01:01.83: [21838]: --> [7:CONNECT]
Jan 26 12:01:02.78: [21838]: --> [2:10 03]
Jan 26 12:01:02.78: [21838]: --> [10:NO CARRIER]
Jan 26 12:01:02.78: [21838]: MODEM No carrier
Jan 26 12:01:02.78: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:01:09.78: [21838]: --> [0:]
Jan 26 12:01:09.78: [21838]: MODEM <Empty line>
Jan 26 12:01:09.78: [21838]: MODEM TIMEOUT: waiting for v.21 carrier
Jan 26 12:01:09.78: [21838]: <-- data [1]
Jan 26 12:01:09.79: [21838]: --> [2:]
Jan 26 12:01:09.79: [21838]: --> [2:OK]
Jan 26 12:01:09.79: [21838]: <-- [9:AT+FRH=3\r]
Jan 26 12:01:19.81: [21838]: --> [10:NO CARRIER]
Jan 26 12:01:19.81: [21838]: MODEM No carrier
Jan 26 12:01:19.81: [21838]: Failed to properly detect high-speed data
carrier. {E112}
Jan 26 12:01:19.82: [21838]: RECV/CQ: Adjusting for EOFB at row 538
Jan 26 12:01:19.82: [21838]: RECV: 14080 bytes of data, 538 total lines
Jan 26 12:01:19.82: [21838]: RECV keeping unconfirmed page
Jan 26 12:01:19.82: [21838]: RECV FAX (000000489): from XXXXXXXXXXXX,
page 1 in 0:01:00, A4, 3.85 line/mm, 2-D MMR, 9600 bit/s
Jan 26 12:01:20.82: [21838]: RECV FAX (000000489):
recvq/fax000000332.tif from XXXXXXXXXXXX, subaddress <unspecified>, 1
pages in 0:01:00
Jan 26 12:01:20.82: [21838]: RECV FAX: Failed to properly detect
high-speed data carrier. {E112}
Jan 26 12:01:20.82: [21838]: <-- [9:AT+FRS=7\r]
Jan 26 12:01:21.18: [21838]: --> [2:OK]
Jan 26 12:01:21.18: [21838]: <-- [9:AT+FTH=3\r]
Jan 26 12:01:22.15: [21838]: --> [7:CONNECT]
Jan 26 12:01:22.15: [21838]: <-- HDLC<3:FF C8 5F>
Jan 26 12:01:22.15: [21838]: <-- data [3]
Jan 26 12:01:22.15: [21838]: <-- data [2]
Jan 26 12:01:22.54: [21838]: --> [2:OK]
Jan 26 12:01:22.54: [21838]: MODEM input buffering enabled
Jan 26 12:01:22.54: [21838]: RECV FAX (000000489): session with
902826846875 terminated abnormally: Failed to properly detect high-speed
data carrier. {E112}
Jan 26 12:01:22.54: [21838]: RECV FAX: bin/faxrcvd
'recvq/fax000000332.tif' 'ttyUSB0' '000000489' 'Failed to properly
detect high-speed data carrier. {E112}'
Jan 26 12:01:22.54: [21838]: RECV FAX: end
Jan 26 12:01:22.54: [21838]: SESSION END


At the moment, only solution is to ask to send to a manual fax.

Regards

Davide

Ralph Shepard ha scritto:
> Just re-read my post... to be clear, the Diva Card is in my Hylafax
> Server...  no idea what is on the other end....
> 
> Thanks...
> Ralph
> 
> On Tue, 2009-02-10 at 19:54 -0600, Ralph Shepard wrote:
>> Hi All,
>>
>> Wondering if anyone has run into this issue?  We have several instances
>> where we end up getting the same fax over and over, for some reason it
>> looks like the modem (Actually a Dialogic Diva Pri/T1 Card) on the
>> machine on the far end don't wrap up the call correctly and so the far
>> end resends...
>>
>> It's somewhat annoying any one have any ideas?  Session log from a
>> representative follows...
>>
>> Thanks,
>> Ralph 
>>
>>


____________________ 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*