[hylafax-users] Problem with receiving, pages are not complete

["Jonny Berthiaume" <jberthiaume@xxxxxxxxxx>]

Hi,

I got a problem with my setup. About 20% of my faxes are received with
missing lines on the pages.

For example, I receive a fax of 4 pages. In these 4 pages, the first
is complete up to the half of the page, the second has the same
problem, the third is complete but the fourth is suffering from the
same problem. I do have a log for this case, but I will put it at the
bottom of this message. You will notice that I don't receive all the
expected lines, but I can't figure out why.

Another example, which is a more common problem to me, is I receive a
fax of 3 pages. The first is complete, the second is only complete to
the 3/4 of the page and the last is complete to the half. I don't have
the log under my hand right now, but when I looked at it I have seen
the number of received row/lines getting lower and lower every page.

I use a very old setup, HylaFAX 4.1.5 on Slackware 8.1. I got 3
Multitech 5634-NV-ZPX modems and the 2 problems occur on all of them.
Upgrade is not an option, don't mention it.

I would say there are 3 possibilities. First my modems got a wrong
configuration that cause those problems. The second possibility would
be a problem on my phone lines. The last one would be a problem on the
land lines of our phone company or the client having a really bad fax
machine.

In the last case, I would not be able to do much. I don't think the
problems are from outside sources because I get the problems with more
than one of our clients. It still could be a land line problem, but
80% of my faxes are fine. I don't want to rule out this possibility,
but it's unlikely.

As for my own phone lines, we switch to a T1 2 months ago. I am not
sure if my fax lines have been moved to the T1, but we had no problem
until 2 weeks ago. If the lines have been switched to the T1, this
could likely be the core of my problem.

I think the problems are more likely caused by our lines setup, but I
want to know first if everything looks fine with my fax log. If I can
rule out the modems and HylaFAX then this will let me only one choice,
testing the T1.

Here is one of my configuration file for my modems
############
CountryCode:        1
AreaCode:               418
FAXNumber:              +1.418.999.9999
LongDistancePrefix: 1
InternationalPrefix:    011
DialStringRules:        etc/dialrules
ServerTracing:      1
SessionTracing:     11
RecvFileMode:       0664
LogFileMode:        0600
DeviceMode:     0666
RingsBeforeAnswer:      1
SpeakerVolume:          off
GettyArgs:      ""
LocalIdentifier:        "GNI Inc."
TagLineFont:        etc/lutRS18.pcf
TagLineFormat:          "De:  %%l  |%Y/%m/%d  %H:%M:%S|Page %%p de %%t"
MaxRecvPages:           99
ModemType:      Class1      # use this to supply a hint
ModemRate:      19200       # rate for DCE-DTE communication
ModemFlowControl:   xonxoff
ModemNoFlowCmd:     AT&K0       # setup no flow control
ModemHardFlowCmd:   AT&K3       # setup hardware flow control
ModemSoftFlowCmd:   AT&K4       # setup software flow control
ModemSetupDTRCmd:   AT&D2       # setup so DTR drop resets modem
ModemSetupDCDCmd:   AT&C1       # setup so DCD reflects carrier (or not)
ModemMfrQueryCmd:   !Rockwell
ModemModelQueryCmd: !RC288DPi
ModemRevQueryCmd:   ATI3        # product information
ModemDialCmd:       ATDT%s
ModemPriority:          "255"
RecvDataFormat:     "1-D MR"
PercentGoodLines:    75
MaxConsecutiveBadLines:    15

######################


Here one of the logs from a fax with the chopping problem
######################

Sep 17 12:38:29.19: [  302]: SESSION BEGIN 00094058 14189999999
Sep 17 12:38:29.19: [  302]: HylaFAX (tm) Version 4.1.5
Sep 17 12:38:29.19: [  302]: MODEM set XON/XOFF/FLUSH: input ignored,
output disabled
Sep 17 12:38:29.19: [  302]: <-- [4:ATA\r]
Sep 17 12:38:35.36: [  302]: --> [7:CONNECT]
Sep 17 12:38:35.36: [  302]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS6'
Sep 17 12:38:35.36: [  302]: STATE CHANGE: ANSWERING -> RECEIVING
Sep 17 12:38:35.36: [  302]: MODEM input buffering enabled
Sep 17 12:38:35.36: [  302]: RECV FAX: begin
Sep 17 12:38:35.37: [  302]: MODEM input buffering disabled
Sep 17 12:38:35.38: [  302]: <-- HDLC<23:FF C0 02 F6 C6 4E A6 6E A6 4E
0A 04 04 04 04 04 04 04 04 04 04 04 04>
Sep 17 12:38:35.38: [  302]: <-- data [23]
Sep 17 12:38:35.38: [  302]: <-- data [2]
Sep 17 12:38:35.42: [  302]: --> [7:CONNECT]
Sep 17 12:38:35.42: [  302]: <-- HDLC<10:FF C8 01 00 77 5F 01 79 03 C0>
Sep 17 12:38:35.42: [  302]: <-- data [10]
Sep 17 12:38:35.42: [  302]: <-- data [2]
Sep 17 12:38:36.60: [  302]: --> [2:OK]
Sep 17 12:38:36.60: [  302]: <-- [9:AT+FRH=3\r]
Sep 17 12:38:36.77: [  302]: --> [7:CONNECT]
Sep 17 12:38:38.51: [  302]: --> HDLC<25:FF C0 C2 0C 0C EC 9C AC 9C EC
2C 1C AC 0C 9C 04 04 04 04 04 04 04 04 B9 F3>
Sep 17 12:38:38.51: [  302]: --> [2:OK]
Sep 17 12:38:38.51: [  302]: REMOTE TSI "905847959700"
Sep 17 12:38:38.51: [  302]: <-- [9:AT+FRH=3\r]
Sep 17 12:38:38.52: [  302]: --> [7:CONNECT]
Sep 17 12:38:38.83: [  302]: --> HDLC<11:FF C8 C1 00 60 15 01 01 00 0A 70>
Sep 17 12:38:38.83: [  302]: --> [2:OK]
Sep 17 12:38:38.83: [  302]: REMOTE wants 9600 bit/s
Sep 17 12:38:38.83: [  302]: REMOTE wants page width 1728 pixels in 215 mm
Sep 17 12:38:38.83: [  302]: REMOTE wants unlimited page length
Sep 17 12:38:38.83: [  302]: REMOTE wants 3.85 line/mm
Sep 17 12:38:38.83: [  302]: REMOTE wants 1-D MR
Sep 17 12:38:38.83: [  302]: RECV training at v.29 9600 bit/s
Sep 17 12:38:38.83: [  302]: MODEM set XON/XOFF/DRAIN: input ignored,
output generated
Sep 17 12:38:38.83: [  302]: <-- [10:AT+FRM=96\r]
Sep 17 12:38:39.20: [  302]: --> [7:CONNECT]
Sep 17 12:38:40.73: [  302]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Sep 17 12:38:40.73: [  302]: RECV: TCF 1824 bytes, 0% non-zero, 1816 zero-run
Sep 17 12:38:40.73: [  302]: --> [10:NO CARRIER]
Sep 17 12:38:40.73: [  302]: DELAY 75 ms
Sep 17 12:38:40.81: [  302]: TRAINING succeeded
Sep 17 12:38:40.81: [  302]: <-- [9:AT+FTH=3\r]
Sep 17 12:38:41.67: [  302]: --> [7:CONNECT]
Sep 17 12:38:41.67: [  302]: <-- HDLC<3:FF C8 21>
Sep 17 12:38:41.67: [  302]: <-- data [3]
Sep 17 12:38:41.67: [  302]: <-- data [2]
Sep 17 12:38:41.99: [  302]: --> [2:OK]
Sep 17 12:38:41.99: [  302]: MODEM input buffering enabled
Sep 17 12:38:41.99: [  302]: MODEM set XON/XOFF/FLUSH: input ignored,
output generated
Sep 17 12:38:41.99: [  302]: <-- [10:AT+FRM=96\r]
Sep 17 12:38:43.36: [  302]: --> [7:CONNECT]
Sep 17 12:38:43.36: [  302]: RECV: begin page
Sep 17 12:39:05.57: [  302]: RECV/CQ: Bad 1D pixel count, row 1058,
got 0, expected 1728
Sep 17 12:39:05.57: [  302]: RECV/CQ: Bad 1D pixel count, row 1059,
got 0, expected 1728
Sep 17 12:39:05.57: [  302]: RECV/CQ: Bad 1D pixel count, row 1060,
got 0, expected 1728
Sep 17 12:39:05.57: [  302]: RECV/CQ: Bad 1D pixel count, row 1061,
got 0, expected 1728
Sep 17 12:39:05.57: [  302]: RECV/CQ: Bad 1D pixel count, row 1062,
got 0, expected 1728
Sep 17 12:39:05.57: [  302]: RECV/CQ: Adjusting for RTC found at row 1057
Sep 17 12:39:05.57: [  302]: RECV: 1057 total lines, 0 bad lines, 0
consecutive bad lines
Sep 17 12:39:05.57: [  302]: RECV: end page
Sep 17 12:39:05.57: [  302]: --> [10:NO CARRIER]
Sep 17 12:39:05.57: [  302]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Sep 17 12:39:05.57: [  302]: MODEM input buffering disabled
Sep 17 12:39:05.57: [  302]: <-- [9:AT+FRH=3\r]
Sep 17 12:39:05.69: [  302]: --> [7:CONNECT]
Sep 17 12:39:06.74: [  302]: --> HDLC<5:FF C8 F2 AC A0>
Sep 17 12:39:06.74: [  302]: --> [2:OK]
Sep 17 12:39:06.74: [  302]: RECV recv MPS (more pages, same document)
Sep 17 12:39:06.74: [  302]: <-- [9:AT+FRS=7\r]
Sep 17 12:39:06.83: [  302]: --> [2:OK]
Sep 17 12:39:06.83: [  302]: <-- [9:AT+FTH=3\r]
Sep 17 12:39:07.69: [  302]: --> [7:CONNECT]
Sep 17 12:39:07.69: [  302]: RECV send MCF (message confirmation)
Sep 17 12:39:07.69: [  302]: RECV FAX (00094058): from 999999999999,
page 1 in 0:27, INF, 3.85 line/mm, 1-D MR, 9600 bit/s
Sep 17 12:39:07.69: [  302]: <-- HDLC<3:FF C8 31>
Sep 17 12:39:07.69: [  302]: <-- data [3]
Sep 17 12:39:07.69: [  302]: <-- data [2]
Sep 17 12:39:08.01: [  302]: --> [2:OK]
Sep 17 12:39:08.01: [  302]: MODEM input buffering enabled
Sep 17 12:39:08.01: [  302]: MODEM set XON/XOFF/FLUSH: input ignored,
output generated
Sep 17 12:39:08.01: [  302]: <-- [10:AT+FRM=96\r]
Sep 17 12:39:09.35: [  302]: --> [7:CONNECT]
Sep 17 12:39:09.35: [  302]: RECV: begin page
Sep 17 12:39:31.90: [  302]: RECV/CQ: Bad 1D pixel count, row 1058,
got 0, expected 1728
Sep 17 12:39:31.90: [  302]: RECV/CQ: Bad 1D pixel count, row 1059,
got 0, expected 1728
Sep 17 12:39:31.90: [  302]: RECV/CQ: Bad 1D pixel count, row 1060,
got 0, expected 1728
Sep 17 12:39:31.90: [  302]: RECV/CQ: Bad 1D pixel count, row 1061,
got 0, expected 1728
Sep 17 12:39:31.90: [  302]: RECV/CQ: Bad 1D pixel count, row 1062,
got 0, expected 1728
Sep 17 12:39:31.90: [  302]: RECV/CQ: Adjusting for RTC found at row 1057
Sep 17 12:39:31.90: [  302]: RECV: 1057 total lines, 0 bad lines, 0
consecutive bad lines
Sep 17 12:39:31.90: [  302]: RECV: end page
Sep 17 12:39:31.90: [  302]: --> [10:NO CARRIER]
Sep 17 12:39:31.90: [  302]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Sep 17 12:39:31.90: [  302]: MODEM input buffering disabled
Sep 17 12:39:31.91: [  302]: <-- [9:AT+FRH=3\r]
Sep 17 12:39:32.04: [  302]: --> [7:CONNECT]
Sep 17 12:39:33.05: [  302]: --> HDLC<5:FF C8 F2 AC A0>
Sep 17 12:39:33.05: [  302]: --> [2:OK]
Sep 17 12:39:33.05: [  302]: RECV recv MPS (more pages, same document)
Sep 17 12:39:33.05: [  302]: <-- [9:AT+FRS=7\r]
Sep 17 12:39:33.15: [  302]: --> [2:OK]
Sep 17 12:39:33.15: [  302]: <-- [9:AT+FTH=3\r]
Sep 17 12:39:34.01: [  302]: --> [7:CONNECT]
Sep 17 12:39:34.01: [  302]: RECV send MCF (message confirmation)
Sep 17 12:39:34.01: [  302]: RECV FAX (00094058): from 999999999999,
page 2 in 0:27, INF, 3.85 line/mm, 1-D MR, 9600 bit/s
Sep 17 12:39:34.01: [  302]: <-- HDLC<3:FF C8 31>
Sep 17 12:39:34.01: [  302]: <-- data [3]
Sep 17 12:39:34.01: [  302]: <-- data [2]
Sep 17 12:39:34.33: [  302]: --> [2:OK]
Sep 17 12:39:34.33: [  302]: MODEM input buffering enabled
Sep 17 12:39:34.33: [  302]: MODEM set XON/XOFF/FLUSH: input ignored,
output generated
Sep 17 12:39:34.33: [  302]: <-- [10:AT+FRM=96\r]
Sep 17 12:39:35.69: [  302]: --> [7:CONNECT]
Sep 17 12:39:35.69: [  302]: RECV: begin page
Sep 17 12:40:04.51: [  302]: RECV/CQ: Bad 1D pixel count, row 1829,
got 0, expected 1728
Sep 17 12:40:04.51: [  302]: RECV/CQ: Bad 1D pixel count, row 1830,
got 0, expected 1728
Sep 17 12:40:04.51: [  302]: RECV/CQ: Bad 1D pixel count, row 1831,
got 0, expected 1728
Sep 17 12:40:04.51: [  302]: RECV/CQ: Bad 1D pixel count, row 1832,
got 0, expected 1728
Sep 17 12:40:04.51: [  302]: RECV/CQ: Bad 1D pixel count, row 1833,
got 0, expected 1728
Sep 17 12:40:04.51: [  302]: RECV/CQ: Adjusting for RTC found at row 1828
Sep 17 12:40:04.51: [  302]: RECV: 1828 total lines, 0 bad lines, 0
consecutive bad lines
Sep 17 12:40:04.51: [  302]: RECV: end page
Sep 17 12:40:04.51: [  302]: --> [10:NO CARRIER]
Sep 17 12:40:04.51: [  302]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Sep 17 12:40:04.51: [  302]: MODEM input buffering disabled
Sep 17 12:40:04.51: [  302]: <-- [9:AT+FRH=3\r]
Sep 17 12:40:04.65: [  302]: --> [7:CONNECT]
Sep 17 12:40:05.68: [  302]: --> HDLC<5:FF C8 F2 AC A0>
Sep 17 12:40:05.68: [  302]: --> [2:OK]
Sep 17 12:40:05.68: [  302]: RECV recv MPS (more pages, same document)
Sep 17 12:40:05.68: [  302]: <-- [9:AT+FRS=7\r]
Sep 17 12:40:05.78: [  302]: --> [2:OK]
Sep 17 12:40:05.78: [  302]: <-- [9:AT+FTH=3\r]
Sep 17 12:40:06.64: [  302]: --> [7:CONNECT]
Sep 17 12:40:06.64: [  302]: RECV send MCF (message confirmation)
Sep 17 12:40:06.64: [  302]: RECV FAX (00094058): from 999999999999,
page 3 in 0:32, INF, 3.85 line/mm, 1-D MR, 9600 bit/s
Sep 17 12:40:06.64: [  302]: <-- HDLC<3:FF C8 31>
Sep 17 12:40:06.64: [  302]: <-- data [3]
Sep 17 12:40:06.64: [  302]: <-- data [2]
Sep 17 12:40:06.96: [  302]: --> [2:OK]
Sep 17 12:40:06.96: [  302]: MODEM input buffering enabled
Sep 17 12:40:06.96: [  302]: MODEM set XON/XOFF/FLUSH: input ignored,
output generated
Sep 17 12:40:06.96: [  302]: <-- [10:AT+FRM=96\r]
Sep 17 12:40:08.42: [  302]: --> [7:CONNECT]
Sep 17 12:40:08.42: [  302]: RECV: begin page
Sep 17 12:40:33.21: [  302]: RECV/CQ: Bad 1D pixel count, row 1149,
got 0, expected 1728
Sep 17 12:40:33.21: [  302]: RECV/CQ: Bad 1D pixel count, row 1150,
got 0, expected 1728
Sep 17 12:40:33.21: [  302]: RECV/CQ: Bad 1D pixel count, row 1151,
got 0, expected 1728
Sep 17 12:40:33.21: [  302]: RECV/CQ: Bad 1D pixel count, row 1152,
got 0, expected 1728
Sep 17 12:40:33.21: [  302]: RECV/CQ: Bad 1D pixel count, row 1153,
got 0, expected 1728
Sep 17 12:40:33.21: [  302]: RECV/CQ: Adjusting for RTC found at row 1148
Sep 17 12:40:33.21: [  302]: RECV: 1148 total lines, 0 bad lines, 0
consecutive bad lines
Sep 17 12:40:33.21: [  302]: RECV: end page
Sep 17 12:40:33.21: [  302]: --> [10:NO CARRIER]
Sep 17 12:40:33.21: [  302]: MODEM set XON/XOFF/DRAIN: input ignored,
output disabled
Sep 17 12:40:33.21: [  302]: MODEM input buffering disabled
Sep 17 12:40:33.21: [  302]: <-- [9:AT+FRH=3\r]
Sep 17 12:40:33.35: [  302]: --> [7:CONNECT]
Sep 17 12:40:34.38: [  302]: --> HDLC<5:FF C8 F4 CC 66>
Sep 17 12:40:34.38: [  302]: --> [2:OK]
Sep 17 12:40:34.38: [  302]: RECV recv EOP (no more pages or documents)
Sep 17 12:40:34.38: [  302]: <-- [9:AT+FRS=7\r]
Sep 17 12:40:34.48: [  302]: --> [2:OK]
Sep 17 12:40:34.48: [  302]: <-- [9:AT+FTH=3\r]
Sep 17 12:40:35.34: [  302]: --> [7:CONNECT]
Sep 17 12:40:35.34: [  302]: <-- HDLC<3:FF C8 31>
Sep 17 12:40:35.34: [  302]: <-- data [3]
Sep 17 12:40:35.34: [  302]: <-- data [2]
Sep 17 12:40:35.66: [  302]: --> [2:OK]
Sep 17 12:40:35.66: [  302]: RECV send MCF (message confirmation)
Sep 17 12:40:35.66: [  302]: RECV FAX (00094058): from 999999999999,
page 4 in 0:29, INF, 3.85 line/mm, 1-D MR, 9600 bit/s
Sep 17 12:40:35.66: [  302]: RECV FAX (00094058): recvq/fax16532.tif
from 999999999999, route to <unspecified>, 4 pages in 2:00
Sep 17 12:40:35.66: [  302]: <-- [9:AT+FRH=3\r]
Sep 17 12:40:35.79: [  302]: --> [7:CONNECT]
Sep 17 12:40:36.98: [  302]: --> HDLC<5:FF C8 DF 59 6F>
Sep 17 12:40:36.98: [  302]: --> [2:OK]
Sep 17 12:40:36.98: [  302]: MODEM input buffering enabled
Sep 17 12:40:36.98: [  302]: RECV FAX: bin/faxrcvd
"recvq/fax16532.tif" "ttyS6" "00094058" "" "" ""
Sep 17 12:40:37.14: [  302]: RECV FAX: end
Sep 17 12:40:37.14: [  302]: SESSION END

###################

Thanks for the help,

Jonny Berthiaume


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