Re: [hylafax-users] Receiving corrupted faxes.

["dev.malst" <dev.malst@xxxxxxxxxxxx>]

We tried with different Modems without success.

We tried with a standard fax machine also, instead of hylafax as receiver. Not many times to be fair, but on an attempt normal fax machine received 5 pages fax fine, hylafax received 2 of 5 pages fine.

We have Fastweb as provider, an Italian Internet provider that uses our ISDN 30 lines Primary and digitalize flow with CISCO router (not properly VoIP but some type of digitalization takes place…).

 

Below another example (There are happening 4 types of poor communication):

 

Oct 19 10:14:25.69: [21831]: SESSION BEGIN 000019912 XXXXXXXXXXXX

Oct 19 10:14:25.69: [21831]: HylaFAX (tm) Version 4.4.4

Oct 19 10:14:25.69: [21831]: <-- [4:ATA\r]

Oct 19 10:14:31.64: [21831]: --> [7:CONNECT]

Oct 19 10:14:31.64: [21831]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyUSB3'

Oct 19 10:14:31.64: [21831]: RECV FAX: begin

Oct 19 10:14:31.64: [21831]: <-- data [32]

Oct 19 10:14:31.64: [21831]: <-- data [2]

Oct 19 10:14:33.67: [21831]: --> [7:CONNECT]

Oct 19 10:14:33.67: [21831]: <-- data [23]

Oct 19 10:14:33.67: [21831]: <-- data [2]

Oct 19 10:14:34.50: [21831]: --> [7:CONNECT]

Oct 19 10:14:34.50: [21831]: <-- data [13]

Oct 19 10:14:34.50: [21831]: <-- data [2]

Oct 19 10:14:35.15: [21831]: --> [2:OK]

Oct 19 10:14:35.15: [21831]: <-- [9:AT+FRH=3\r]

Oct 19 10:14:36.48: [21831]: --> [7:CONNECT]

Oct 19 10:14:38.04: [21831]: --> [2:OK]

Oct 19 10:14:38.04: [21831]: REMOTE TSI "XXXXXXXXX"

Oct 19 10:14:38.04: [21831]: RECV recv TSI (sender id)

Oct 19 10:14:38.04: [21831]: <-- [9:AT+FRH=3\r]

Oct 19 10:14:38.05: [21831]: --> [7:CONNECT]

Oct 19 10:14:38.39: [21831]: --> [2:OK]

Oct 19 10:14:38.39: [21831]: REMOTE wants 9600 bit/s

Oct 19 10:14:38.39: [21831]: REMOTE wants A4 page width (215 mm)

Oct 19 10:14:38.39: [21831]: REMOTE wants unlimited page length

Oct 19 10:14:38.39: [21831]: REMOTE wants 3.85 line/mm

Oct 19 10:14:38.39: [21831]: REMOTE wants 1-D MH

Oct 19 10:14:38.39: [21831]: RECV recv DCS (command signal)

Oct 19 10:14:38.39: [21831]: RECV training at v.29 9600 bit/s

Oct 19 10:14:38.39: [21831]: <-- [10:AT+FRM=96\r]

Oct 19 10:14:38.77: [21831]: --> [7:CONNECT]

Oct 19 10:14:40.14: [21831]: RECV: TCF 1615 bytes, 2% non-zero, 1575 zero-run

Oct 19 10:14:40.14: [21831]: --> [10:NO CARRIER]

Oct 19 10:14:40.14: [21831]: <-- [9:AT+FRS=7\r]

Oct 19 10:14:40.26: [21831]: --> [2:OK]

Oct 19 10:14:40.26: [21831]: TRAINING succeeded

Oct 19 10:14:40.26: [21831]: <-- [9:AT+FTH=3\r]

Oct 19 10:14:40.31: [21831]: --> [7:CONNECT]

Oct 19 10:14:40.31: [21831]: <-- data [3]

Oct 19 10:14:40.31: [21831]: <-- data [2]

Oct 19 10:14:41.62: [21831]: --> [2:OK]

Oct 19 10:14:41.62: [21831]: <-- [10:AT+FRM=96\r]

Oct 19 10:14:44.26: [21831]: --> [7:CONNECT]

Oct 19 10:14:44.26: [21831]: RECV: begin page

Oct 19 10:14:50.52: [21831]: RECV: 11 total lines, 10 bad lines, 7 consecutive bad lines

Oct 19 10:14:50.52: [21831]: RECV: REJECT page quality, 9% good lines (95% required)

Oct 19 10:14:50.52: [21831]: RECV: end page

Oct 19 10:14:50.64: [21831]: --> [10:NO CARRIER]

Oct 19 10:14:50.64: [21831]: <-- [9:AT+FRH=3\r]

Oct 19 10:15:06.92: [21831]: --> [7:CONNECT]

Oct 19 10:15:06.92: [21831]: --> [5:ERROR]

Oct 19 10:15:06.92: [21831]: MODEM Command error

Oct 19 10:15:06.92: [21831]: FCS error

Oct 19 10:15:06.92: [21831]: <-- [10:AT+FRS=21\r]

Oct 19 10:15:07.29: [21831]: --> [2:OK]

Oct 19 10:15:07.29: [21831]: <-- [9:AT+FTH=3\r]

Oct 19 10:15:07.44: [21831]: --> [7:CONNECT]

Oct 19 10:15:07.44: [21831]: <-- data [3]

Oct 19 10:15:07.44: [21831]: <-- data [2]

Oct 19 10:15:08.75: [21831]: --> [2:OK]

Oct 19 10:15:08.75: [21831]: RECV send CRP (command repeat)

Oct 19 10:15:08.75: [21831]: <-- [9:AT+FRH=3\r]

Oct 19 10:15:11.59: [21831]: --> [7:CONNECT]

Oct 19 10:15:12.62: [21831]: --> [2:OK]

Oct 19 10:15:12.62: [21831]: RECV recv MPS (more pages, same document)

Oct 19 10:15:12.62: [21831]: <-- [9:AT+FRS=7\r]

Oct 19 10:15:12.84: [21831]: --> [2:OK]

Oct 19 10:15:12.84: [21831]: <-- [9:AT+FTH=3\r]

Oct 19 10:15:12.99: [21831]: --> [7:CONNECT]

Oct 19 10:15:12.99: [21831]: RECV send RTN (retrain negative)

Oct 19 10:15:12.99: [21831]: <-- data [3]

Oct 19 10:15:12.99: [21831]: <-- data [2]

Oct 19 10:15:12.99: [21831]: RECV FAX (000019912): from 050720728, page 1 in 0:19, INF, 3.85 line/mm, 1-D MH, 9600 bit/s

Oct 19 10:15:14.30: [21831]: --> [2:OK]

Oct 19 10:15:14.30: [21831]: <-- [9:AT+FRH=3\r]

Oct 19 10:15:15.58: [21831]: --> [7:CONNECT]

Oct 19 10:15:17.14: [21831]: --> [2:OK]

Oct 19 10:15:17.14: [21831]: REMOTE TSI "XXXXXXXXX"

Oct 19 10:15:17.14: [21831]: RECV recv TSI (sender id)

Oct 19 10:15:17.14: [21831]: <-- [9:AT+FRH=3\r]

Oct 19 10:15:17.49: [21831]: --> [7:CONNECT]

Oct 19 10:15:17.49: [21831]: --> [2:OK]

Oct 19 10:15:17.49: [21831]: REMOTE wants 9600 bit/s

Oct 19 10:15:17.49: [21831]: REMOTE wants A4 page width (215 mm)

Oct 19 10:15:17.49: [21831]: REMOTE wants unlimited page length

Oct 19 10:15:17.49: [21831]: REMOTE wants 3.85 line/mm

Oct 19 10:15:17.49: [21831]: REMOTE wants 1-D MH

Oct 19 10:15:17.49: [21831]: RECV recv DCS (command signal)

Oct 19 10:15:17.49: [21831]: RECV training at v.29 9600 bit/s

Oct 19 10:15:17.49: [21831]: <-- [10:AT+FRM=96\r]

Oct 19 10:15:17.86: [21831]: --> [7:CONNECT]

Oct 19 10:15:19.22: [21831]: RECV: TCF 1590 bytes, 2% non-zero, 1551 zero-run

Oct 19 10:15:19.22: [21831]: --> [10:NO CARRIER]

Oct 19 10:15:19.22: [21831]: <-- [9:AT+FRS=7\r]

Oct 19 10:15:19.44: [21831]: --> [2:OK]

Oct 19 10:15:19.44: [21831]: TRAINING succeeded

Oct 19 10:15:19.44: [21831]: <-- [9:AT+FTH=3\r]

Oct 19 10:15:19.59: [21831]: --> [7:CONNECT]

Oct 19 10:15:19.59: [21831]: <-- data [3]

Oct 19 10:15:19.59: [21831]: <-- data [2]

Oct 19 10:15:20.90: [21831]: --> [2:OK]

Oct 19 10:15:20.90: [21831]: <-- [10:AT+FRM=96\r]

Oct 19 10:15:22.47: [21831]: --> [7:CONNECT]

Oct 19 10:15:22.47: [21831]: RECV: begin page

Oct 19 10:15:25.42: [21831]: RECV: 3 total lines, 3 bad lines, 3 consecutive bad lines

Oct 19 10:15:25.42: [21831]: RECV: REJECT page quality, 0% good lines (95% required)

Oct 19 10:15:25.42: [21831]: RECV: end page

Oct 19 10:15:25.42: [21831]: --> [10:NO CARRIER]

Oct 19 10:15:25.42: [21831]: <-- [9:AT+FRH=3\r]

Oct 19 10:16:15.73: [21831]: --> [10:NO CARRIER]

Oct 19 10:16:15.73: [21831]: MODEM No carrier

Oct 19 10:16:15.73: [21831]: RECV keeping unconfirmed page

Oct 19 10:16:15.73: [21831]: RECV FAX (000019912): from 050720728, page 2 in 0:35, INF, 3.85 line/mm, 1-D MH, 9600 bit/s

Oct 19 10:16:15.73: [21831]: RECV FAX (000019912): recvq/fax000019908.tif from 050720728, route to <unspecified>, 2 pages in 1:44

Oct 19 10:16:15.73: [21831]: RECV FAX: T.30 T2 timeout, expected page not received

Oct 19 10:16:15.73: [21831]: <-- [9:AT+FTH=3\r]

Oct 19 10:16:15.88: [21831]: --> [7:CONNECT]

Oct 19 10:16:15.88: [21831]: <-- data [3]

Oct 19 10:16:15.88: [21831]: <-- data [2]

Oct 19 10:16:17.20: [21831]: --> [2:OK]

Oct 19 10:16:17.20: [21831]: RECV FAX (000019912): session with 050720728 terminated abnormally: T.30 T2 timeout, expected page not received

Oct 19 10:16:17.20: [21831]: RECV FAX: bin/faxrcvd "recvq/fax000019908.tif" "ttyUSB3" "000019912" "T.30 T2 timeout, expected page not received"

Oct 19 10:16:17.20: [21831]: RECV FAX: end

Oct 19 10:16:17.20: [21831]: T.30 T2 timeout, expected page not received

Oct 19 10:16:17.20: [21831]: SESSION END

 

 

 

 

 

 

 

 

 

 

 

 

APS wrote:

Oct 07 11:20:58.01: [13649]: SESSION BEGIN 000019095 XXXXXXXXXXXX
Oct 07 11:20:58.01: [13649]: HylaFAX (tm) Version 4.4.4
Oct 07 11:20:58.01: [13649]: <-- [4:ATA\r]
Oct 07 11:21:06.26: [13649]: --> [7:CONNECT]
Oct 07 11:21:06.26: [13649]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyUSB4'
Oct 07 11:21:06.26: [13649]: RECV FAX: begin
Oct 07 11:21:06.26: [13649]: <-- data [32]
Oct 07 11:21:06.26: [13649]: <-- data [2]
Oct 07 11:21:06.29: [13649]: --> [7:CONNECT]
Oct 07 11:21:06.29: [13649]: <-- data [23]
Oct 07 11:21:06.29: [13649]: <-- data [2]
Oct 07 11:21:06.31: [13649]: --> [7:CONNECT]
Oct 07 11:21:06.31: [13649]: <-- data [13]
Oct 07 11:21:06.31: [13649]: <-- data [2]
Oct 07 11:21:08.52: [13649]: --> [2:OK]
Oct 07 11:21:08.52: [13649]: <-- [9:AT+FRH=3\r]
Oct 07 11:21:15.52: [13649]: --> [0:]
Oct 07 11:21:15.52: [13649]: MODEM <Empty line>
Oct 07 11:21:15.52: [13649]: <-- data [1]
Oct 07 11:21:15.53: [13649]: --> [2:

]
Oct 07 11:21:15.53: [13649]: --> [2:OK]

After answering and sending prologue signals the modem cannot hear any fax tones from the sender.

Oct 07 11:21:15.53: [13649]: <-- [9:AT+FRS=7\r]
Oct 07 11:21:15.61: [13649]: --> [2:OK]
Oct 07 11:21:15.61: [13649]: <-- [9:AT+FTH=3\r]
Oct 07 11:21:16.48: [13649]: --> [7:CONNECT]
Oct 07 11:21:16.48: [13649]: <-- data [32]
Oct 07 11:21:16.48: [13649]: <-- data [2]
Oct 07 11:21:16.50: [13649]: --> [7:CONNECT]
Oct 07 11:21:16.50: [13649]: <-- data [23]
Oct 07 11:21:16.50: [13649]: <-- data [2]
Oct 07 11:21:16.53: [13649]: --> [7:CONNECT]
Oct 07 11:21:16.53: [13649]: <-- data [13]
Oct 07 11:21:16.53: [13649]: <-- data [2]
Oct 07 11:21:18.74: [13649]: --> [2:OK]
Oct 07 11:21:18.74: [13649]: <-- [9:AT+FRH=3\r]
Oct 07 11:21:21.40: [13649]: --> [7:CONNECT]
Oct 07 11:21:23.85: [13649]: --> [2:OK]
Oct 07 11:21:23.85: [13649]: RECV recv CRP (command repeat)

Okay, there is a real fax machine at the other end.  It asked us to repeat our prologue signals...

Oct 07 11:21:23.85: [13649]: <-- [9:AT+FTH=3\r]
Oct 07 11:21:24.72: [13649]: --> [7:CONNECT]
Oct 07 11:21:24.72: [13649]: <-- data [32]
Oct 07 11:21:24.72: [13649]: <-- data [2]
Oct 07 11:21:24.74: [13649]: --> [7:CONNECT]
Oct 07 11:21:24.74: [13649]: <-- data [23]
Oct 07 11:21:24.74: [13649]: <-- data [2]
Oct 07 11:21:24.77: [13649]: --> [7:CONNECT]
Oct 07 11:21:24.77: [13649]: <-- data [13]
Oct 07 11:21:24.77: [13649]: <-- data [2]
Oct 07 11:21:26.98: [13649]: --> [2:OK]
Oct 07 11:21:26.98: [13649]: <-- [9:AT+FRH=3\r]
Oct 07 11:21:29.64: [13649]: --> [7:CONNECT]
Oct 07 11:21:32.09: [13649]: --> [2:OK]
Oct 07 11:21:32.09: [13649]: RECV recv CRP (command repeat)

After repeating the prologue signals it again asks us to repeat ourselves...

Oct 07 11:21:32.09: [13649]: <-- [9:AT+FTH=3\r]
Oct 07 11:21:32.96: [13649]: --> [7:CONNECT]
Oct 07 11:21:32.96: [13649]: <-- data [32]
Oct 07 11:21:32.96: [13649]: <-- data [2]
Oct 07 11:21:32.98: [13649]: --> [7:CONNECT]
Oct 07 11:21:32.98: [13649]: <-- data [23]
Oct 07 11:21:32.98: [13649]: <-- data [2]
Oct 07 11:21:33.01: [13649]: --> [7:CONNECT]
Oct 07 11:21:33.01: [13649]: <-- data [13]
Oct 07 11:21:33.01: [13649]: <-- data [2]
Oct 07 11:21:35.22: [13649]: --> [2:OK]
Oct 07 11:21:35.22: [13649]: <-- [9:AT+FRH=3\r]
Oct 07 11:21:37.88: [13649]: --> [7:CONNECT]
Oct 07 11:21:40.33: [13649]: --> [2:OK]
Oct 07 11:21:40.33: [13649]: RECV recv CRP (command repeat)

And again... (it would seem that the sender can't hear us very well).

Oct 07 11:21:40.33: [13649]: <-- [9:AT+FTH=3\r]
Oct 07 11:21:41.19: [13649]: --> [7:CONNECT]
Oct 07 11:21:41.19: [13649]: <-- data [32]
Oct 07 11:21:41.19: [13649]: <-- data [2]
Oct 07 11:21:41.22: [13649]: --> [7:CONNECT]
Oct 07 11:21:41.22: [13649]: <-- data [23]
Oct 07 11:21:41.22: [13649]: <-- data [2]
Oct 07 11:21:41.24: [13649]: --> [7:CONNECT]
Oct 07 11:21:41.24: [13649]: <-- data [13]
Oct 07 11:21:41.24: [13649]: <-- data [2]
Oct 07 11:21:43.45: [13649]: --> [2:OK]
Oct 07 11:21:43.45: [13649]: <-- [9:AT+FRH=3\r]
Oct 07 11:21:46.12: [13649]: --> [7:CONNECT]
Oct 07 11:21:48.57: [13649]: --> [2:OK]
Oct 07 11:21:48.57: [13649]: RECV recv CRP (command repeat)

Again...

Oct 07 11:21:48.57: [13649]: RECV FAX: No sender protocol (T.30 T1 timeout)
Oct 07 11:21:48.57: [13649]: RECV FAX: end
Oct 07 11:21:48.57: [13649]: No sender protocol (T.30 T1 timeout)
Oct 07 11:21:48.57: [13649]: SESSION END

We gave up.  It would seem that the audio quality on the line was too poor for the audio to get through correctly in this case.

Since you're seeing 15-20% error rate it would seem to me that the problem is on your end.  Are you using VoIP lines?  Have you had your phone lines checked?  Have you tried a different type of modem?

Thanks,

Lee.