HylaFAX The world's most advanced open source fax server
[Date Prev][Date Next][Thread Prev][Thread Next] [Date Index] [Thread Index]

[hylafax-users] RECV/CQ: Bad 1D pixel count ...

	Hi Lee and all,

	I've been following your suggestions about VoIP and faxes, and in order
to avoid these kind of problems i've replaced the asterisk pbx with a
traditional analog Panasonic PBX (Model KX-T206SP). The results are that
i have the same problems :-(, so i don't think it's a VoIP issue now. 

	As you also suggested i've tried to send faxes from one hylafax server
to another hylafax server:

Hylafax Linux ------ Modem ---- Panasonic ---- Modem ----- Hylafax linux
Server				PBX				Server

And here are the session logs of each one, sender and receiver:

SENDER:
-----------------------

Mar 10 12:28:38.62: [ 1092]: SESSION BEGIN 000000040 349121
Mar 10 12:28:38.62: [ 1092]: HylaFAX (tm) Version 4.2.1
Mar 10 12:28:38.62: [ 1092]: SEND FAX: JOB 27 DEST 21 COMMID 000000040
DEVICE '/dev/ttyS0'
Mar 10 12:28:38.62: [ 1092]: STATE CHANGE: RUNNING -> SENDING
Mar 10 12:28:38.62: [ 1092]: MODEM input buffering enabled
Mar 10 12:28:38.62: [ 1092]: Apply DialString rules to "21"
Mar 10 12:28:38.62: [ 1092]: --> return result "21"
Mar 10 12:28:38.62: [ 1092]: <-- [12:AT+FCLASS=1\r]
Mar 10 12:28:38.82: [ 1092]: --> [2:OK]
Mar 10 12:28:38.82: [ 1092]: MODEM set XON/XOFF/FLUSH: input ignored,
output disabled
Mar 10 12:28:38.82: [ 1092]: DIAL 21
Mar 10 12:28:38.82: [ 1092]: <-- [7:ATDT21\r]
Mar 10 12:29:02.48: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:02.48: [ 1092]: MODEM input buffering disabled
Mar 10 12:29:04.24: [ 1092]: --> HDLC<34: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 B1 17>
Mar 10 12:29:04.24: [ 1092]: --> [2:OK]
Mar 10 12:29:04.24: [ 1092]: REMOTE NSF "B5 00 AA 48 79 6C 61 46 41 58
20 28 74 6D 29 20 56 65 72 73 69 6F 6E 20 34 2E 32 2E 31"
Mar 10 12:29:04.24: [ 1092]: NSF remote fax equipment: HylaFAX 
Mar 10 12:29:04.24: [ 1092]: NSF remote station ID: "HylaFAX (tm)
Version 4.2.1"
Mar 10 12:29:04.24: [ 1092]: <-- [9:AT+FRH=3\r]
Mar 10 12:29:04.26: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:05.04: [ 1092]: --> HDLC<25:FF C0 02 0E AE 2E A6 CA E6 76
96 16 2E F6 72 04 04 04 04 04 04 04 04 7C F4>
Mar 10 12:29:05.05: [ 1092]: --> [2:OK]
Mar 10 12:29:05.05: [ 1092]: REMOTE CSI "NothingSetup"
Mar 10 12:29:05.05: [ 1092]: <-- [9:AT+FRH=3\r]
Mar 10 12:29:05.07: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:05.42: [ 1092]: --> HDLC<9:FF C8 01 00 76 5F 00 C6 4A>
Mar 10 12:29:05.44: [ 1092]: --> [2:OK]
Mar 10 12:29:05.44: [ 1092]: REMOTE best rate 14400 bit/s
Mar 10 12:29:05.44: [ 1092]: REMOTE max A3 page width (303 mm)
Mar 10 12:29:05.44: [ 1092]: REMOTE max unlimited page length
Mar 10 12:29:05.44: [ 1092]: REMOTE best vres 7.7 line/mm
Mar 10 12:29:05.44: [ 1092]: REMOTE best format 1-D MH
Mar 10 12:29:05.44: [ 1092]: REMOTE best 0 ms/scanline
Mar 10 12:29:05.44: [ 1092]: USE 14400 bit/s
Mar 10 12:29:05.44: [ 1092]: USE 0 ms/scanline
Mar 10 12:29:05.44: [ 1092]: SEND file "docq/doc31.ps;c0"
Mar 10 12:29:05.44: [ 1092]: USE A4 page width (215 mm)
Mar 10 12:29:05.44: [ 1092]: USE unlimited page length
Mar 10 12:29:05.44: [ 1092]: USE 3.85 line/mm
Mar 10 12:29:05.44: [ 1092]: USE 1-D MH
Mar 10 12:29:05.45: [ 1092]: SEND training at v.17 14400 bit/s
Mar 10 12:29:05.45: [ 1092]: <-- [9:AT+FTH=3\r]
Mar 10 12:29:05.49: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:05.49: [ 1092]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76
96 16 2E F6 72 04 04 04 04 04 04 04 04>
Mar 10 12:29:05.49: [ 1092]: <-- data [23]
Mar 10 12:29:05.49: [ 1092]: <-- data [2]
Mar 10 12:29:05.52: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:05.52: [ 1092]: <-- HDLC<6:FF C8 C1 00 44 1E>
Mar 10 12:29:05.52: [ 1092]: <-- data [6]
Mar 10 12:29:05.52: [ 1092]: <-- data [2]
Mar 10 12:29:07.69: [ 1092]: --> [2:OK]
Mar 10 12:29:07.69: [ 1092]: DELAY 70 ms
Mar 10 12:29:07.76: [ 1092]: MODEM set XON/XOFF/FLUSH: input
interpreted, output disabled
Mar 10 12:29:07.76: [ 1092]: <-- [11:AT+FTM=145\r]
Mar 10 12:29:09.44: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:09.44: [ 1092]: <-- data [1024]
Mar 10 12:29:09.44: [ 1092]: <-- data [1024]
Mar 10 12:29:09.44: [ 1092]: <-- data [652]
Mar 10 12:29:09.44: [ 1092]: <-- data [2]
Mar 10 12:29:10.99: [ 1092]: --> [2:OK]
Mar 10 12:29:10.99: [ 1092]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Mar 10 12:29:10.99: [ 1092]: <-- [9:AT+FRH=3\r]
Mar 10 12:29:11.55: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:12.67: [ 1092]: --> HDLC<5:FF C8 21 57 BE>
Mar 10 12:29:12.72: [ 1092]: --> [2:OK]
Mar 10 12:29:12.72: [ 1092]: TRAINING succeeded
Mar 10 12:29:12.72: [ 1092]: DELAY 200 ms
Mar 10 12:29:12.92: [ 1092]: <-- [11:AT+FTM=146\r]
Mar 10 12:29:13.42: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:13.42: [ 1092]: MODEM set XON/XOFF/FLUSH: input
interpreted, output disabled
Mar 10 12:29:13.42: [ 1092]: SEND begin page
Mar 10 12:29:13.42: [ 1092]: Reading MMR-compressed image file
Mar 10 12:29:13.46: [ 1092]: <-- data [1025]
Mar 10 12:29:13.46: [ 1092]: <-- data [1032]
Mar 10 12:29:13.46: [ 1092]: <-- data [1030]
Mar 10 12:29:13.46: [ 1092]: <-- data [1024]
Mar 10 12:29:13.46: [ 1092]: <-- data [1029]
Mar 10 12:29:15.46: [ 1092]: <-- data [1027]
Mar 10 12:29:15.46: [ 1092]: <-- data [1025]
Mar 10 12:29:15.46: [ 1092]: <-- data [1028]
Mar 10 12:29:17.45: [ 1092]: <-- data [1027]
Mar 10 12:29:17.45: [ 1092]: <-- data [1027]
Mar 10 12:29:17.45: [ 1092]: <-- data [1024]
Mar 10 12:29:17.45: [ 1092]: <-- data [1029]
Mar 10 12:29:19.45: [ 1092]: <-- data [1028]
Mar 10 12:29:19.45: [ 1092]: <-- data [1027]
Mar 10 12:29:19.45: [ 1092]: <-- data [1029]
Mar 10 12:29:19.45: [ 1092]: <-- data [1031]
Mar 10 12:29:21.45: [ 1092]: <-- data [1025]
Mar 10 12:29:21.45: [ 1092]: <-- data [1027]
Mar 10 12:29:21.45: [ 1092]: <-- data [1029]
Mar 10 12:29:23.44: [ 1092]: <-- data [1029]
Mar 10 12:29:23.44: [ 1092]: <-- data [1025]
Mar 10 12:29:23.44: [ 1092]: <-- data [1025]
Mar 10 12:29:23.44: [ 1092]: <-- data [1026]
Mar 10 12:29:25.44: [ 1092]: <-- data [1027]
Mar 10 12:29:25.44: [ 1092]: <-- data [1025]
Mar 10 12:29:25.44: [ 1092]: <-- data [1025]
Mar 10 12:29:25.44: [ 1092]: <-- data [1024]
Mar 10 12:29:27.44: [ 1092]: <-- data [1027]
Mar 10 12:29:27.44: [ 1092]: <-- data [1025]
Mar 10 12:29:27.44: [ 1092]: <-- data [1025]
Mar 10 12:29:27.44: [ 1092]: <-- data [1026]
Mar 10 12:29:29.43: [ 1092]: <-- data [1026]
Mar 10 12:29:29.43: [ 1092]: <-- data [1026]
Mar 10 12:29:29.43: [ 1092]: <-- data [1026]
Mar 10 12:29:31.43: [ 1092]: <-- data [1028]
Mar 10 12:29:31.43: [ 1092]: <-- data [1026]
Mar 10 12:29:31.43: [ 1092]: <-- data [1029]
Mar 10 12:29:31.43: [ 1092]: <-- data [1029]
Mar 10 12:29:33.43: [ 1092]: <-- data [283]
Mar 10 12:29:33.43: [ 1092]: SENT 39195 bytes of data
Mar 10 12:29:33.43: [ 1092]: SEND 1D RTC
Mar 10 12:29:33.43: [ 1092]: <-- data [29]
Mar 10 12:29:33.43: [ 1092]: <-- data [2]
Mar 10 12:29:33.43: [ 1092]: SEND end page
Mar 10 12:29:35.54: [ 1092]: --> [2:OK]
Mar 10 12:29:35.54: [ 1092]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Mar 10 12:29:35.54: [ 1092]: DELAY 90 ms
Mar 10 12:29:35.63: [ 1092]: SEND send EOP (no more pages or documents)
Mar 10 12:29:35.63: [ 1092]: <-- [9:AT+FTH=3\r]
Mar 10 12:29:35.68: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:35.68: [ 1092]: <-- HDLC<3:FF C8 F4>
Mar 10 12:29:35.68: [ 1092]: <-- data [3]
Mar 10 12:29:35.68: [ 1092]: <-- data [2]
Mar 10 12:29:37.00: [ 1092]: --> [2:OK]
Mar 10 12:29:37.00: [ 1092]: <-- [9:AT+FRH=3\r]
Mar 10 12:29:37.38: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:38.50: [ 1092]: --> HDLC<5:FF C8 31 45 8F>
Mar 10 12:29:38.55: [ 1092]: --> [2:OK]
Mar 10 12:29:38.55: [ 1092]: SEND recv MCF (message confirmation)
Mar 10 12:29:38.56: [ 1092]: DELAY 70 ms
Mar 10 12:29:38.56: [ 1092]: SEND FAX (000000040): FROM root@pbx00009 TO
21 (page 1 of 1 sent in 0:33)
Mar 10 12:29:38.62: [ 1092]: SEND FAX (000000040): FROM root@pbx00009 TO
21 (docq/doc31.ps;c0 sent in 0:33)
Mar 10 12:29:39.57: [ 1092]: <-- [9:AT+FTH=3\r]
Mar 10 12:29:39.62: [ 1092]: --> [7:CONNECT]
Mar 10 12:29:39.62: [ 1092]: <-- HDLC<3:FF C8 DF>
Mar 10 12:29:39.62: [ 1092]: <-- data [3]
Mar 10 12:29:39.62: [ 1092]: <-- data [2]
Mar 10 12:29:40.93: [ 1092]: --> [2:OK]
Mar 10 12:29:40.93: [ 1092]: MODEM input buffering enabled
Mar 10 12:29:40.93: [ 1092]: <-- [5:ATH0\r]
Mar 10 12:29:41.36: [ 1092]: --> [10:NO CARRIER]
Mar 10 12:29:41.36: [ 1092]: MODEM No carrier
Mar 10 12:29:41.36: [ 1092]: MODEM set DTR OFF
Mar 10 12:29:41.36: [ 1092]: STATE CHANGE: SENDING -> MODEMWAIT (timeout
5)
Mar 10 12:29:41.36: [ 1092]: SESSION END

RECEIVER:
-----------------------

Mar 10 12:28:48.54: [ 4936]: SESSION BEGIN 000000056 34916330001
Mar 10 12:28:48.54: [ 4936]: HylaFAX (tm) Version 4.2.1
Mar 10 12:28:48.54: [ 4936]: MODEM set XON/XOFF/FLUSH: input ignored,
output disabled
Mar 10 12:28:48.54: [ 4936]: <-- [4:ATA\r]
Mar 10 12:28:56.50: [ 4936]: --> [7:CONNECT]
Mar 10 12:28:56.50: [ 4936]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Mar 10 12:28:56.50: [ 4936]: STATE CHANGE: ANSWERING -> RECEIVING
Mar 10 12:28:56.50: [ 4936]: MODEM input buffering enabled
Mar 10 12:28:56.50: [ 4936]: RECV FAX: begin
Mar 10 12:28:56.50: [ 4936]: MODEM input buffering disabled
Mar 10 12:28:56.50: [ 4936]: <-- 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>
Mar 10 12:28:56.50: [ 4936]: <-- data [32]
Mar 10 12:28:56.50: [ 4936]: <-- data [2]
Mar 10 12:28:56.53: [ 4936]: --> [7:CONNECT]
Mar 10 12:28:56.53: [ 4936]: <-- HDLC<23:FF C0 02 0E AE 2E A6 CA E6 76
96 16 2E F6 72 04 04 04 04 04 04 04 04>
Mar 10 12:28:56.53: [ 4936]: <-- data [23]
Mar 10 12:28:56.53: [ 4936]: <-- data [2]
Mar 10 12:28:56.56: [ 4936]: --> [7:CONNECT]
Mar 10 12:28:56.56: [ 4936]: <-- HDLC<10:FF C8 01 00 76 5F 23 01 FB C0>
Mar 10 12:28:56.56: [ 4936]: <-- data [10]
Mar 10 12:28:56.56: [ 4936]: <-- data [2]
Mar 10 12:28:59.66: [ 4936]: --> [2:OK]
Mar 10 12:28:59.66: [ 4936]: <-- [9:AT+FRH=3\r]
Mar 10 12:28:59.88: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:01.54: [ 4936]: --> HDLC<25:FF C0 C2 0E AE 2E A6 CA E6 76
96 16 2E F6 72 04 04 04 04 04 04 04 04 51 6E>
Mar 10 12:29:01.55: [ 4936]: --> [2:OK]
Mar 10 12:29:01.55: [ 4936]: REMOTE TSI "NothingSetup"
Mar 10 12:29:01.55: [ 4936]: <-- [9:AT+FRH=3\r]
Mar 10 12:29:01.57: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:01.89: [ 4936]: --> HDLC<8:FF C8 C1 00 44 1E 63 22>
Mar 10 12:29:01.93: [ 4936]: --> [2:OK]
Mar 10 12:29:01.93: [ 4936]: REMOTE wants 14400 bit/s
Mar 10 12:29:01.93: [ 4936]: REMOTE wants A4 page width (215 mm)
Mar 10 12:29:01.93: [ 4936]: REMOTE wants unlimited page length
Mar 10 12:29:01.93: [ 4936]: REMOTE wants 3.85 line/mm
Mar 10 12:29:01.93: [ 4936]: REMOTE wants 1-D MH
Mar 10 12:29:01.93: [ 4936]: RECV training at v.17 14400 bit/s
Mar 10 12:29:01.93: [ 4936]: MODEM set XON/XOFF/DRAIN: input ignored,
output generated
Mar 10 12:29:01.93: [ 4936]: <-- [11:AT+FRM=145\r]
Mar 10 12:29:03.71: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:05.49: [ 4936]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Mar 10 12:29:05.49: [ 4936]: RECV: TCF 2520 bytes, 0% non-zero, 2520
zero-run
Mar 10 12:29:05.49: [ 4936]: --> [10:NO CARRIER]
Mar 10 12:29:05.49: [ 4936]: DELAY 75 ms
Mar 10 12:29:05.57: [ 4936]: TRAINING succeeded
Mar 10 12:29:05.57: [ 4936]: <-- [9:AT+FTH=3\r]
Mar 10 12:29:05.62: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:05.62: [ 4936]: <-- HDLC<3:FF C8 21>
Mar 10 12:29:05.62: [ 4936]: <-- data [3]
Mar 10 12:29:05.62: [ 4936]: <-- data [2]
Mar 10 12:29:06.94: [ 4936]: --> [2:OK]
Mar 10 12:29:06.94: [ 4936]: MODEM input buffering enabled
Mar 10 12:29:06.94: [ 4936]: MODEM set XON/XOFF/FLUSH: input ignored,
output generated
Mar 10 12:29:06.94: [ 4936]: <-- [11:AT+FRM=146\r]
Mar 10 12:29:07.96: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:07.96: [ 4936]: RECV: begin page
Mar 10 12:29:08.42: [ 4936]: RECV/CQ: Bad 1D pixel count, row 170, got
1771, expected 1728
Mar 10 12:29:13.55: [ 4936]: RECV/CQ: Bad 1D pixel count, row 480, got
2916, expected 1728
Mar 10 12:29:13.55: [ 4936]: RECV/CQ: Bad 1D pixel count, row 481, got
2667, expected 1728
Mar 10 12:29:16.49: [ 4936]: RECV/CQ: Bad 1D pixel count, row 571, got
1755, expected 1728
Mar 10 12:29:16.57: [ 4936]: RECV/CQ: Bad 1D pixel count, row 572, got
1933, expected 1728
Mar 10 12:29:18.39: [ 4936]: RECV/CQ: Bad 1D pixel count, row 653, got
803, expected 1728
Mar 10 12:29:18.47: [ 4936]: RECV/CQ: Bad 1D pixel count, row 654, got
1692, expected 1728
Mar 10 12:29:23.44: [ 4936]: RECV/CQ: Bad 1D pixel count, row 823, got
1679, expected 1728
Mar 10 12:29:25.07: [ 4936]: RECV/CQ: Bad 1D pixel count, row 869, got
2042, expected 1728
Mar 10 12:29:28.49: [ 4936]: RECV/CQ: Bad 1D pixel count, row 1039, got
29, expected 1728
Mar 10 12:29:28.49: [ 4936]: RECV/CQ: Bad 1D pixel count, row 1043, got
0, expected 1728
Mar 10 12:29:28.49: [ 4936]: RECV/CQ: Bad 1D pixel count, row 1044, got
0, expected 1728
Mar 10 12:29:28.49: [ 4936]: RECV/CQ: Bad 1D pixel count, row 1045, got
0, expected 1728
Mar 10 12:29:28.49: [ 4936]: RECV/CQ: Bad 1D pixel count, row 1046, got
0, expected 1728
Mar 10 12:29:28.90: [ 4936]: RECV/CQ: Adjusting for RTC found at row
1043
Mar 10 12:29:28.90: [ 4936]: RECV: 1043 total lines, 10 bad lines, 2
consecutive bad lines
Mar 10 12:29:28.90: [ 4936]: RECV: end page
Mar 10 12:29:28.90: [ 4936]: --> [10:NO CARRIER]
Mar 10 12:29:28.90: [ 4936]: <-- [9:AT+FRH=3\r]
Mar 10 12:29:30.17: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:31.33: [ 4936]: --> HDLC<5:FF C8 F4 CC 66>
Mar 10 12:29:31.33: [ 4936]: --> [2:OK]
Mar 10 12:29:31.33: [ 4936]: RECV recv EOP (no more pages or documents)
Mar 10 12:29:31.33: [ 4936]: DELAY 70 ms
Mar 10 12:29:31.40: [ 4936]: <-- [9:AT+FTH=3\r]
Mar 10 12:29:31.56: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:31.56: [ 4936]: <-- HDLC<3:FF C8 31>
Mar 10 12:29:31.56: [ 4936]: <-- data [3]
Mar 10 12:29:31.56: [ 4936]: <-- data [2]
Mar 10 12:29:32.87: [ 4936]: --> [2:OK]
Mar 10 12:29:32.87: [ 4936]: RECV send MCF (message confirmation)
Mar 10 12:29:32.87: [ 4936]: <-- [9:AT+FRH=3\r]
Mar 10 12:29:32.87: [ 4936]: RECV FAX (000000056): from NothingSetup,
page 1 in 0:27, INF, 3.85 line/mm, 1-D MH, 14400 bit/s
Mar 10 12:29:32.87: [ 4936]: RECV FAX (000000056):
recvq/fax000000045.tif from NothingSetup, route to <unspecified>, 1
pages in 0:36
Mar 10 12:29:34.10: [ 4936]: --> [7:CONNECT]
Mar 10 12:29:35.28: [ 4936]: --> HDLC<5:FF C8 DF 59 6F>
Mar 10 12:29:35.28: [ 4936]: --> [2:OK]
Mar 10 12:29:35.28: [ 4936]: MODEM input buffering enabled
Mar 10 12:29:35.28: [ 4936]: RECV FAX: bin/faxrcvd
"recvq/fax000000045.tif" "ttyS0" "000000056" "" "" ""
Mar 10 12:29:35.28: [ 4936]: RECV FAX: end
Mar 10 12:29:35.28: [ 4936]: SESSION END

	
	I hope any of you can give any tip or any idea about which can be the
problem now, because i don't know what more things i could try.

Thanks in advance.

PD: I've tried to connect directly from the server to the receiver with
a cable, and use faxanswer but i haven't been able to make it work. The
receiver never answers. Any idea? 

-- 
Diego Chaparro
Grupo de Sistemas y Comunicaciones
Universidad Rey Juan Carlos
C/ Tulipan s/n - 28933 Mostoles
dchaparro@xxxxxxxxxxxxxxxxxx  ||  dchaparro@xxxxxxx


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

Project hosted by iFAX Solutions