[hylafax-users] The tif images doesn't exist in the recvq directory

["Marcelo Godois Tavares" <mtavares@xxxxxxxxxxx>]

Hi all.

 

Hylafax is running using three external modems, plugged-in different COM ports in a Linux Ubuntu 8.04 machine, and has been completed almost 2000 faxes received without any problem (we don’t send, just receive faxes :). But now, I’m getting some problems, as showed bellow, and the TIF file has not been created in the recvq directory, although it is in the log.

 

The disk has enough free space. But the recvq and log directorys have, of course, almost 2000 files each :). So, I’m not sure it will work, but I tried to clean up those directory, and restart the Hylafax to see what happens, because the clients didn’t change, so I’m lost! J

 

I would be happy if anyone had the answer for this problem. Because, I like using Hylafax, but my boss is having some doubts about it. Thank you everybody and really sorry for my bad English!

 

Have a nice day.

 

Dec 02 12:51:12.36: [ 6619]: SESSION BEGIN 000001548 18008826608

Dec 02 12:51:12.36: [ 6619]: HylaFAX (tm) Version 4.4.3

Dec 02 12:51:12.36: [ 6619]: MODEM set XON/XOFF/FLUSH: input ignored, output disabled

Dec 02 12:51:12.36: [ 6619]: <-- [13:AT+FCLASS=1A\r]

Dec 02 12:51:17.80: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:17.80: [ 6619]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS1'

Dec 02 12:51:17.80: [ 6619]: STATE CHANGE: ANSWERING -> RECEIVING

Dec 02 12:51:17.80: [ 6619]: RECV FAX: begin

Dec 02 12:51:17.80: [ 6619]: <-- 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 2C 74 2C 74 CC>

Dec 02 12:51:17.80: [ 6619]: <-- data [32]

Dec 02 12:51:17.80: [ 6619]: <-- data [2]

Dec 02 12:51:17.97: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:17.97: [ 6619]: <-- HDLC<23:FF C0 02 22 A2 B2 CA 92 22 04 04 04 04 04 04 04 04 04 04 04 04 04 04>

Dec 02 12:51:17.97: [ 6619]: <-- data [23]

Dec 02 12:51:17.97: [ 6619]: <-- data [2]

Dec 02 12:51:18.69: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:18.69: [ 6619]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>

Dec 02 12:51:18.69: [ 6619]: <-- data [13]

Dec 02 12:51:18.69: [ 6619]: <-- data [2]

Dec 02 12:51:20.95: [ 6619]: --> [2:OK]

Dec 02 12:51:20.95: [ 6619]: <-- [9:AT+FRH=3\r]

Dec 02 12:51:21.57: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:22.95: [ 6619]: --> HDLC<25:FF C0 C2 22 4A F2 72 04 C2 A2 42 A2 AA 8A 04 CA CA CA C2 04 04 04 04 BB 1B>

Dec 02 12:51:22.95: [ 6619]: --> [2:OK]

Dec 02 12:51:22.95: [ 6619]: REMOTE TSI "CSSS QUEBEC NORD"

Dec 02 12:51:22.95: [ 6619]: RECV recv TSI (sender id)

Dec 02 12:51:22.95: [ 6619]: <-- [9:AT+FRH=3\r]

Dec 02 12:51:22.97: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:23.25: [ 6619]: --> HDLC<10:FF C8 C1 00 46 1F 23 00 31 44>

Dec 02 12:51:23.25: [ 6619]: --> [2:OK]

Dec 02 12:51:23.25: [ 6619]: REMOTE wants 14400 bit/s

Dec 02 12:51:23.25: [ 6619]: REMOTE wants A4 page width (215 mm)

Dec 02 12:51:23.25: [ 6619]: REMOTE wants unlimited page length

Dec 02 12:51:23.25: [ 6619]: REMOTE wants 7.7 line/mm

Dec 02 12:51:23.25: [ 6619]: REMOTE wants 2-D MMR

Dec 02 12:51:23.25: [ 6619]: REMOTE wants T.30 Annex A, 256-byte ECM

Dec 02 12:51:23.25: [ 6619]: RECV recv DCS (command signal)

Dec 02 12:51:23.25: [ 6619]: RECV training at v.17 14400 bit/s

Dec 02 12:51:23.25: [ 6619]: MODEM set XON/XOFF/DRAIN: input ignored, output generated

Dec 02 12:51:23.25: [ 6619]: <-- [11:AT+FRM=145\r]

Dec 02 12:51:24.93: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:26.49: [ 6619]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled

Dec 02 12:51:26.49: [ 6619]: RECV: TCF 2811 bytes, 3% non-zero, 2699 zero-run

Dec 02 12:51:26.49: [ 6619]: --> [10:NO CARRIER]

Dec 02 12:51:26.49: [ 6619]: DELAY 70 ms

Dec 02 12:51:26.57: [ 6619]: TRAINING succeeded

Dec 02 12:51:26.57: [ 6619]: <-- [9:AT+FTH=3\r]

Dec 02 12:51:26.76: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:26.76: [ 6619]: <-- HDLC<3:FF C8 21>

Dec 02 12:51:26.76: [ 6619]: <-- data [3]

Dec 02 12:51:26.76: [ 6619]: <-- data [2]

Dec 02 12:51:27.94: [ 6619]: --> [2:OK]

Dec 02 12:51:27.94: [ 6619]: <-- [11:AT+FRM=146\r]

Dec 02 12:51:34.94: [ 6619]: MODEM TIMEOUT: reading line from modem

Dec 02 12:51:34.94: [ 6619]: <-- data [1]

Dec 02 12:51:35.14: [ 6619]: MODEM TIMEOUT: reading line from modem

Dec 02 12:51:35.14: [ 6619]: MODEM <Timeout>

Dec 02 12:51:35.14: [ 6619]: <-- [9:AT+FRH=3\r]

Dec 02 12:51:37.99: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:40.27: [ 6619]: --> [15:14 63 F6 96 93 2A 03 D9 1E 22 CC A1 00 10 03]

Dec 02 12:51:40.27: [ 6619]: --> [5:ERROR]

Dec 02 12:51:40.27: [ 6619]: MODEM Command error

Dec 02 12:51:40.27: [ 6619]: FCS error

Dec 02 12:51:40.27: [ 6619]: DELAY 70 ms

Dec 02 12:51:40.34: [ 6619]: <-- [9:AT+FTH=3\r]

Dec 02 12:51:40.54: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:40.54: [ 6619]: <-- HDLC<3:FF C8 58>

Dec 02 12:51:40.54: [ 6619]: <-- data [3]

Dec 02 12:51:40.54: [ 6619]: <-- data [2]

Dec 02 12:51:41.71: [ 6619]: --> [2:OK]

Dec 02 12:51:41.71: [ 6619]: RECV send CRP (command repeat)

Dec 02 12:51:41.71: [ 6619]: <-- [9:AT+FRH=3\r]

Dec 02 12:51:47.85: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:57.85: [ 6619]: --> [16:52 C3 F0 47 B1 47 A1 A6 41 1B 38 1E C5 DD EA 00]

Dec 02 12:51:57.85: [ 6619]: MODEM TIMEOUT: receiving HDLC frame data

Dec 02 12:51:57.85: [ 6619]: <-- data [1]

Dec 02 12:51:57.85: [ 6619]: --> [2:OK]

Dec 02 12:51:57.85: [ 6619]: <-- data [1]

Dec 02 12:51:58.05: [ 6619]: MODEM TIMEOUT: reading line from modem

Dec 02 12:51:58.05: [ 6619]: MODEM <Timeout>

Dec 02 12:51:58.05: [ 6619]: Failed to properly detect high-speed data carrier.

Dec 02 12:51:58.05: [ 6619]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled

Dec 02 12:51:58.05: [ 6619]: RECV FAX (000001548): recvq/fax000001618.tif from ENTERPRISE, route to <unspecified>, 0 pages in 0:41

Dec 02 12:51:58.05: [ 6619]: RECV FAX: Failed to properly detect high-speed data carrier.

Dec 02 12:51:58.05: [ 6619]: <-- [9:AT+FTH=3\r]

Dec 02 12:51:58.09: [ 6619]: --> [7:CONNECT]

Dec 02 12:51:58.09: [ 6619]: <-- HDLC<3:FF C8 5F>

Dec 02 12:51:58.09: [ 6619]: <-- data [3]

Dec 02 12:51:58.09: [ 6619]: <-- data [2]

Dec 02 12:51:59.27: [ 6619]: --> [2:OK]

Dec 02 12:51:59.27: [ 6619]: MODEM input buffering enabled

Dec 02 12:51:59.27: [ 6619]: RECV FAX (000001548): session with ENTERPRISE terminated abnormally: Failed to properly detect high-speed data carrier.

Dec 02 12:51:59.27: [ 6619]: RECV FAX: bin/faxrcvd "recvq/fax000001618.tif" "ttyS1" "000001548" "Failed to properly detect high-speed data carrier."

Dec 02 12:51:59.27: [ 6619]: RECV FAX: end

Dec 02 12:51:59.27: [ 6619]: Failed to properly detect high-speed data carrier.

Dec 02 12:51:59.27: [ 6619]: SESSION END

 

Another log.

 

Dec 02 15:39:19.81: [ 6619]: SESSION BEGIN 000001622 18008826608

Dec 02 15:39:19.81: [ 6619]: HylaFAX (tm) Version 4.4.3

Dec 02 15:39:19.81: [ 6619]: MODEM set XON/XOFF/FLUSH: input ignored, output disabled

Dec 02 15:39:19.81: [ 6619]: <-- [13:AT+FCLASS=1A\r]

Dec 02 15:39:25.26: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:25.26: [ 6619]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS1'

Dec 02 15:39:25.26: [ 6619]: STATE CHANGE: ANSWERING -> RECEIVING

Dec 02 15:39:25.26: [ 6619]: RECV FAX: begin

Dec 02 15:39:25.26: [ 6619]: <-- 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 2C 74 2C 74 CC>

Dec 02 15:39:25.26: [ 6619]: <-- data [32]

Dec 02 15:39:25.26: [ 6619]: <-- data [2]

Dec 02 15:39:25.42: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:25.42: [ 6619]: <-- HDLC<23:FF C0 02 22 A2 B2 CA 92 22 04 04 04 04 04 04 04 04 04 04 04 04 04 04>

Dec 02 15:39:25.42: [ 6619]: <-- data [23]

Dec 02 15:39:25.42: [ 6619]: <-- data [2]

Dec 02 15:39:26.14: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:26.14: [ 6619]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>

Dec 02 15:39:26.14: [ 6619]: <-- data [13]

Dec 02 15:39:26.14: [ 6619]: <-- data [2]

Dec 02 15:39:28.41: [ 6619]: --> [2:OK]

Dec 02 15:39:28.41: [ 6619]: <-- [9:AT+FRH=3\r]

Dec 02 15:39:28.94: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:30.38: [ 6619]: --> HDLC<25:FF C0 C2 4C AC 8C AC B4 0C 1C CC B4 2C 8C AC 04 04 04 04 04 04 8E 0C 24 36>

Dec 02 15:39:30.38: [ 6619]: --> [2:OK]

Dec 02 15:39:30.38: [ 6619]: REMOTE TSI "0q      514-380-5152"

Dec 02 15:39:30.38: [ 6619]: RECV recv TSI (sender id)

Dec 02 15:39:30.38: [ 6619]: <-- [9:AT+FRH=3\r]

Dec 02 15:39:30.40: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:30.75: [ 6619]: --> HDLC<9:FF C8 C1 00 46 1F 00 3D 9B>

Dec 02 15:39:30.75: [ 6619]: --> [2:OK]

Dec 02 15:39:30.75: [ 6619]: REMOTE wants 14400 bit/s

Dec 02 15:39:30.75: [ 6619]: REMOTE wants A4 page width (215 mm)

Dec 02 15:39:30.75: [ 6619]: REMOTE wants unlimited page length

Dec 02 15:39:30.75: [ 6619]: REMOTE wants 7.7 line/mm

Dec 02 15:39:30.75: [ 6619]: REMOTE wants 1-D MH

Dec 02 15:39:30.75: [ 6619]: RECV recv DCS (command signal)

Dec 02 15:39:30.75: [ 6619]: RECV training at v.17 14400 bit/s

Dec 02 15:39:30.75: [ 6619]: MODEM set XON/XOFF/DRAIN: input ignored, output generated

Dec 02 15:39:30.75: [ 6619]: <-- [11:AT+FRM=145\r]

Dec 02 15:39:32.49: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:33.99: [ 6619]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled

Dec 02 15:39:33.99: [ 6619]: RECV: TCF 2723 bytes, 0% non-zero, 2692 zero-run

Dec 02 15:39:34.00: [ 6619]: --> [10:NO CARRIER]

Dec 02 15:39:34.00: [ 6619]: DELAY 70 ms

Dec 02 15:39:34.07: [ 6619]: TRAINING succeeded

Dec 02 15:39:34.08: [ 6619]: <-- [9:AT+FTH=3\r]

Dec 02 15:39:34.27: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:34.27: [ 6619]: <-- HDLC<3:FF C8 21>

Dec 02 15:39:34.27: [ 6619]: <-- data [3]

Dec 02 15:39:34.27: [ 6619]: <-- data [2]

Dec 02 15:39:35.45: [ 6619]: --> [2:OK]

Dec 02 15:39:35.45: [ 6619]: <-- [11:AT+FRM=146\r]

Dec 02 15:39:36.23: [ 6619]: --> [7:CONNECT]

Dec 02 15:39:36.23: [ 6619]: MODEM input buffering enabled

Dec 02 15:39:36.23: [ 6619]: MODEM set XON/XOFF/FLUSH: input ignored, output generated

Dec 02 15:39:36.23: [ 6619]: RECV: begin page

Dec 02 15:40:10.55: [ 6619]: RECV/CQ: Bad 1D pixel count, row 2198, got 0, expected 1728

Dec 02 15:40:10.55: [ 6619]: RECV/CQ: Bad 1D pixel count, row 2199, got 0, expected 1728

Dec 02 15:40:10.55: [ 6619]: RECV/CQ: Bad 1D pixel count, row 2200, got 0, expected 1728

Dec 02 15:40:10.55: [ 6619]: RECV/CQ: Bad 1D pixel count, row 2201, got 0, expected 1728

Dec 02 15:40:10.69: [ 6619]: RECV/CQ: Adjusting for RTC found at row 2198

Dec 02 15:40:10.69: [ 6619]: RECV: 2198 total lines, 0 bad lines, 0 consecutive bad lines

Dec 02 15:40:10.69: [ 6619]: RECV: end page

Dec 02 15:40:10.69: [ 6619]: --> [10:NO CARRIER]

Dec 02 15:40:10.69: [ 6619]: <-- [9:AT+FRH=3\r]

Dec 02 15:40:11.09: [ 6619]: --> [7:CONNECT]

Dec 02 15:40:11.93: [ 6619]: --> HDLC<5:FF C8 F2 AC A0>

Dec 02 15:40:11.93: [ 6619]: --> [2:OK]

Dec 02 15:40:11.93: [ 6619]: RECV recv MPS (more pages, same document)

Dec 02 15:40:11.93: [ 6619]: DELAY 70 ms

Dec 02 15:40:12.00: [ 6619]: <-- [9:AT+FTH=3\r]

Dec 02 15:40:42.00: [ 6619]: MODEM TIMEOUT: reading line from modem

Dec 02 15:40:42.00: [ 6619]: MODEM <Timeout>

Dec 02 15:40:42.02: [ 6619]: RECV FAX (000001622): recvq/fax000001698.tif from 0q      62-555-3153, route to <unspecified>, 0 pages in 1:17

Dec 02 15:40:42.02: [ 6619]: RECV FAX: Failure to raise V.21 transmission carrier.

Dec 02 15:40:42.02: [ 6619]: <-- [9:AT+FTH=3\r]

Dec 02 15:40:42.31: [ 6619]: --> [7:CONNECT]

Dec 02 15:40:42.31: [ 6619]: <-- HDLC<3:FF C8 5F>

Dec 02 15:40:42.31: [ 6619]: <-- data [3]

Dec 02 15:40:42.31: [ 6619]: <-- data [2]

Dec 02 15:40:43.49: [ 6619]: --> [2:OK]

Dec 02 15:40:43.49: [ 6619]: RECV FAX (000001622): session with 0q      62-555-3153 terminated abnormally: Failure to raise V.21 transmission carrier.

Dec 02 15:40:43.49: [ 6619]: RECV FAX: bin/faxrcvd "recvq/fax000001698.tif" "ttyS1" "000001622" "Failure to raise V.21 transmission carrier."

Dec 02 15:40:43.49: [ 6619]: RECV FAX: end

Dec 02 15:40:43.49: [ 6619]: Failure to raise V.21 transmission carrier.

Dec 02 15:40:43.49: [ 6619]: SESSION END