[hylafax-users] COMREC invalid response received to PPS.

[Simon Perry <hylafax@xxxxxxxxxxxxxxxx>]

Hi All,

I am having problems sending a fax with two parts, one pdf and one tiff 
using hylafax 4.2.0 CVS built 02 May. It would appear that hylafax tries 
to send twice, after receiving an "COMREC invalid response received to 
PPS" error on the second page of the first try. On the second attempt 
only the second page is transmitted and that is the only page received. 
If I send the pages separately no error occurs, two or more page pdf or 
ps files also cause no error.

What I am wondering here is if the issue lies with Hylafax or the 
receiver, if I follow hylafax's logic correctly then it is only 
resending page 2 as the receiver acknowledged that it got page one on 
the first try. However when the receiver encountered an error it 
scrapped the whole transmission. I don't know what equipment is on the 
other end, the receiver is a free online service at www.pumaone.com.

Any insight greatly appreciated.

Simon

May 16 12:56:23.56: [21355]: SESSION BEGIN 000000026 4402008707622312
May 16 12:56:23.56: [21355]: HylaFAX (tm) Version 4.2.0-CVS-02-05-2004
May 16 12:56:23.56: [21355]: SEND FAX: JOB 16 DEST 08707622312 COMMID 
000000026 DEVICE '/dev/ttyS0'
May 16 12:56:23.56: [21355]: <-- [12:AT+FCLASS=1\r]
May 16 12:56:23.72: [21355]: --> [2:OK]
May 16 12:56:23.72: [21355]: DIAL 08707622312
May 16 12:56:23.72: [21355]: <-- [16:ATDT08707622312\r]
May 16 12:56:36.25: [21355]: --> [7:CONNECT]
May 16 12:56:37.91: [21355]: --> [2:OK]
May 16 12:56:37.91: [21355]: REMOTE CSI "PUMAONE.COM"
May 16 12:56:37.91: [21355]: <-- [9:AT+FRH=3\r]
May 16 12:56:37.95: [21355]: --> [7:CONNECT]
May 16 12:56:38.20: [21355]: --> [2:OK]
May 16 12:56:38.20: [21355]: REMOTE best rate 14400 bit/s
May 16 12:56:38.20: [21355]: REMOTE max A4 page width (215 mm)
May 16 12:56:38.20: [21355]: REMOTE max unlimited page length
May 16 12:56:38.20: [21355]: REMOTE best vres 7.7 line/mm
May 16 12:56:38.20: [21355]: REMOTE best format 2-D MR
May 16 12:56:38.20: [21355]: REMOTE supports T.30 Annex A, 256-byte ECM
May 16 12:56:38.20: [21355]: REMOTE best 0 ms/scanline
May 16 12:56:38.20: [21355]: USE 14400 bit/s
May 16 12:56:38.20: [21355]: USE error correction mode
May 16 12:56:38.20: [21355]: USE 0 ms/scanline
May 16 12:56:38.20: [21355]: SEND file "docq/doc20.tif;c1"
May 16 12:56:38.20: [21355]: USE A4 page width (215 mm)
May 16 12:56:38.20: [21355]: USE unlimited page length
May 16 12:56:38.20: [21355]: USE 7.7 line/mm
May 16 12:56:38.20: [21355]: USE 2-D MR
May 16 12:56:38.20: [21355]: SEND training at v.17 14400 bit/s
May 16 12:56:38.20: [21355]: <-- [9:AT+FTH=3\r]
May 16 12:56:38.28: [21355]: --> [7:CONNECT]
May 16 12:56:38.28: [21355]: <-- data [23]
May 16 12:56:38.28: [21355]: <-- data [2]
May 16 12:56:40.03: [21355]: --> [7:CONNECT]
May 16 12:56:40.03: [21355]: <-- data [7]
May 16 12:56:40.03: [21355]: <-- data [2]
May 16 12:56:40.36: [21355]: --> [2:OK]
May 16 12:56:40.36: [21355]: DELAY 70 ms
May 16 12:56:40.43: [21355]: <-- [11:AT+FTM=145\r]
May 16 12:56:40.54: [21355]: --> [7:CONNECT]
May 16 12:56:40.54: [21355]: <-- data [1024]
May 16 12:56:40.54: [21355]: <-- data [1024]
May 16 12:56:40.54: [21355]: <-- data [652]
May 16 12:56:40.54: [21355]: <-- data [2]
May 16 12:56:43.70: [21355]: --> [2:OK]
May 16 12:56:43.70: [21355]: <-- [9:AT+FRH=3\r]
May 16 12:56:44.08: [21355]: --> [7:CONNECT]
May 16 12:56:45.30: [21355]: --> [2:OK]
May 16 12:56:45.30: [21355]: TRAINING succeeded
May 16 12:56:45.30: [21355]: SEND begin page
May 16 12:56:45.30: [21355]: Reading MH-compressed image file
May 16 12:56:45.32: [21355]: SEND 2D RTC
May 16 12:56:45.32: [21355]: SEND send frame number 0
<snip />
May 16 12:56:45.38: [21355]: SEND send frame number 235
May 16 12:56:45.38: [21355]: DELAY 200 ms
May 16 12:56:45.58: [21355]: <-- [11:AT+FTM=146\r]
May 16 12:56:45.69: [21355]: --> [7:CONNECT]
May 16 12:56:45.69: [21355]: <-- data [1029]
<snip />
May 16 12:57:19.70: [21355]: <-- data [1033]
May 16 12:57:19.70: [21355]: <-- data [484]
May 16 12:57:19.70: [21355]: <-- data [2]
May 16 12:57:21.64: [21355]: --> [2:OK]
May 16 12:57:21.64: [21355]: DELAY 90 ms
May 16 12:57:21.73: [21355]: <-- [9:AT+FTH=3\r]
May 16 12:57:21.77: [21355]: --> [7:CONNECT]
May 16 12:57:21.77: [21355]: <-- data [7]
May 16 12:57:21.77: [21355]: <-- data [2]
May 16 12:57:23.09: [21355]: --> [2:OK]
May 16 12:57:23.09: [21355]: SEND send PPS (partial page signal)
May 16 12:57:23.09: [21355]: SEND send EOM (more documents)
May 16 12:57:23.09: [21355]: <-- [9:AT+FRH=3\r]
May 16 12:57:23.14: [21355]: --> [7:CONNECT]
May 16 12:57:25.24: [21355]: --> [2:OK]
May 16 12:57:25.24: [21355]: SEND recv PPR (partial page request)
May 16 12:57:25.24: [21355]: DELAY 70 ms
May 16 12:57:25.31: [21355]: SEND send frame number 226
May 16 12:57:25.31: [21355]: SEND send frame number 227
May 16 12:57:25.31: [21355]: DELAY 200 ms
May 16 12:57:25.51: [21355]: <-- [11:AT+FTM=146\r]
May 16 12:57:25.62: [21355]: --> [7:CONNECT]
May 16 12:57:25.62: [21355]: <-- data [915]
May 16 12:57:25.62: [21355]: <-- data [2]
May 16 12:57:26.54: [21355]: --> [2:OK]
May 16 12:57:26.54: [21355]: DELAY 90 ms
May 16 12:57:26.63: [21355]: <-- [9:AT+FTH=3\r]
May 16 12:57:26.67: [21355]: --> [7:CONNECT]
May 16 12:57:26.67: [21355]: <-- data [7]
May 16 12:57:26.67: [21355]: <-- data [2]
May 16 12:57:27.99: [21355]: --> [2:OK]
May 16 12:57:27.99: [21355]: SEND send PPS (partial page signal)
May 16 12:57:27.99: [21355]: SEND send EOM (more documents)
May 16 12:57:27.99: [21355]: <-- [9:AT+FRH=3\r]
May 16 12:57:28.04: [21355]: --> [7:CONNECT]
May 16 12:57:29.26: [21355]: --> [2:OK]
May 16 12:57:29.26: [21355]: SEND recv RNR (receive not ready)
May 16 12:57:29.26: [21355]: DELAY 70 ms
May 16 12:57:29.33: [21355]: <-- [9:AT+FTH=3\r]
May 16 12:57:29.37: [21355]: --> [7:CONNECT]
May 16 12:57:29.37: [21355]: <-- data [3]
May 16 12:57:29.37: [21355]: <-- data [2]
May 16 12:57:30.58: [21355]: --> [2:OK]
May 16 12:57:30.58: [21355]: SEND send RR (receive ready)
May 16 12:57:30.58: [21355]: <-- [9:AT+FRH=3\r]
May 16 12:57:30.69: [21355]: --> [7:CONNECT]
May 16 12:57:31.90: [21355]: --> [2:OK]
May 16 12:57:31.90: [21355]: SEND recv MCF (message confirmation)
May 16 12:57:31.90: [21355]: SEND end page
May 16 12:57:31.90: [21355]: SEND FAX (000000026): FROM simon@faxserver 
TO 08707622312 (page 1 of 2 sent in 0:53)
May 16 12:57:31.90: [21355]: SEND FAX (000000026): FROM simon@faxserver 
TO 08707622312 (docq/doc20.tif;c1 sent in 0:53)
May 16 12:57:31.90: [21355]: SEND file "docq/doc21.ps;c1"
May 16 12:57:31.90: [21355]: USE A4 page width (215 mm)
May 16 12:57:31.90: [21355]: USE unlimited page length
May 16 12:57:31.90: [21355]: USE 7.7 line/mm
May 16 12:57:31.90: [21355]: USE 2-D MR
May 16 12:57:31.90: [21355]: SEND begin page
May 16 12:57:31.91: [21355]: Reading MMR-compressed image file
May 16 12:57:31.93: [21355]: SEND 2D RTC
May 16 12:57:31.93: [21355]: SEND send frame number 0
<snip />
May 16 12:57:31.97: [21355]: SEND send frame number 142
May 16 12:57:31.97: [21355]: DELAY 200 ms
May 16 12:57:32.17: [21355]: <-- [11:AT+FTM=146\r]
May 16 12:57:32.28: [21355]: --> [7:CONNECT]
May 16 12:57:32.28: [21355]: <-- data [1028]
<snip />
May 16 12:57:50.64: [21355]: <-- data [1037]
May 16 12:57:52.93: [21355]: <-- data [670]
May 16 12:57:52.93: [21355]: <-- data [2]
May 16 12:57:54.11: [21355]: --> [2:OK]
May 16 12:57:54.11: [21355]: DELAY 90 ms
May 16 12:57:54.20: [21355]: <-- [9:AT+FTH=3\r]
May 16 12:57:54.24: [21355]: --> [7:CONNECT]
May 16 12:57:54.24: [21355]: <-- data [7]
May 16 12:57:54.24: [21355]: <-- data [2]
May 16 12:57:55.56: [21355]: --> [2:OK]
May 16 12:57:55.56: [21355]: SEND send PPS (partial page signal)
May 16 12:57:55.56: [21355]: SEND send EOP (no more pages or documents)
May 16 12:57:55.56: [21355]: <-- [9:AT+FRH=3\r]
May 16 12:57:55.60: [21355]: --> [7:CONNECT]
May 16 12:57:56.10: [21355]: --> [2:OK]
May 16 12:57:56.10: [21355]: SEND recv MCF (message confirmation)
May 16 12:57:56.10: [21355]: DELAY 70 ms
May 16 12:57:56.17: [21355]: COMREC invalid response received to PPS.
May 16 12:57:56.17: [21355]: SEND end page
May 16 12:57:56.17: [21355]: <-- [9:AT+FTH=3\r]
May 16 12:57:56.21: [21355]: --> [7:CONNECT]
May 16 12:57:56.21: [21355]: <-- data [3]
May 16 12:57:56.21: [21355]: <-- data [2]
May 16 12:57:57.42: [21355]: --> [2:OK]
May 16 12:57:57.42: [21355]: <-- [5:ATH0\r]
May 16 12:57:57.70: [21355]: --> [2:OK]
May 16 12:57:57.70: [21355]: SESSION END

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

May 16 12:59:06.97: [21357]: SESSION BEGIN 000000027 4402008707622312
May 16 12:59:06.97: [21357]: HylaFAX (tm) Version 4.2.0-CVS-02-05-2004
May 16 12:59:06.97: [21357]: SEND FAX: JOB 16 DEST 08707622312 COMMID 
000000027 DEVICE '/dev/ttyS0'
May 16 12:59:06.97: [21357]: <-- [12:AT+FCLASS=1\r]
May 16 12:59:07.14: [21357]: --> [2:OK]
May 16 12:59:07.14: [21357]: DIAL 08707622312
May 16 12:59:07.14: [21357]: <-- [16:ATDT08707622312\r]
May 16 12:59:17.34: [21357]: --> [7:CONNECT]
May 16 12:59:19.00: [21357]: --> [2:OK]
May 16 12:59:19.00: [21357]: REMOTE CSI "PUMAONE.COM"
May 16 12:59:19.00: [21357]: <-- [9:AT+FRH=3\r]
May 16 12:59:19.04: [21357]: --> [7:CONNECT]
May 16 12:59:19.30: [21357]: --> [2:OK]
May 16 12:59:19.30: [21357]: REMOTE best rate 14400 bit/s
May 16 12:59:19.30: [21357]: REMOTE max A4 page width (215 mm)
May 16 12:59:19.30: [21357]: REMOTE max unlimited page length
May 16 12:59:19.30: [21357]: REMOTE best vres 7.7 line/mm
May 16 12:59:19.30: [21357]: REMOTE best format 2-D MMR
May 16 12:59:19.30: [21357]: REMOTE supports T.30 Annex A, 256-byte ECM
May 16 12:59:19.30: [21357]: REMOTE best 0 ms/scanline
May 16 12:59:19.30: [21357]: USE 14400 bit/s
May 16 12:59:19.30: [21357]: USE error correction mode
May 16 12:59:19.30: [21357]: USE 0 ms/scanline
May 16 12:59:19.30: [21357]: SEND file "docq/doc21.ps;c1"
May 16 12:59:19.30: [21357]: USE A4 page width (215 mm)
May 16 12:59:19.30: [21357]: USE unlimited page length
May 16 12:59:19.30: [21357]: USE 7.7 line/mm
May 16 12:59:19.30: [21357]: USE 2-D MMR
May 16 12:59:19.30: [21357]: SEND training at v.17 14400 bit/s
May 16 12:59:19.30: [21357]: <-- [9:AT+FTH=3\r]
May 16 12:59:19.38: [21357]: --> [7:CONNECT]
May 16 12:59:19.38: [21357]: <-- data [23]
May 16 12:59:19.38: [21357]: <-- data [2]
May 16 12:59:21.12: [21357]: --> [7:CONNECT]
May 16 12:59:21.12: [21357]: <-- data [7]
May 16 12:59:21.12: [21357]: <-- data [2]
May 16 12:59:21.45: [21357]: --> [2:OK]
May 16 12:59:21.45: [21357]: DELAY 70 ms
May 16 12:59:21.52: [21357]: <-- [11:AT+FTM=145\r]
May 16 12:59:21.64: [21357]: --> [7:CONNECT]
May 16 12:59:21.64: [21357]: <-- data [1024]
May 16 12:59:21.64: [21357]: <-- data [1024]
May 16 12:59:21.64: [21357]: <-- data [652]
May 16 12:59:21.64: [21357]: <-- data [2]
May 16 12:59:24.80: [21357]: --> [2:OK]
May 16 12:59:24.80: [21357]: <-- [9:AT+FRH=3\r]
May 16 12:59:25.35: [21357]: --> [7:CONNECT]
May 16 12:59:26.57: [21357]: --> [2:OK]
May 16 12:59:26.57: [21357]: TRAINING succeeded
May 16 12:59:26.57: [21357]: SEND begin page
May 16 12:59:26.58: [21357]: SEND EOFB
May 16 12:59:26.58: [21357]: SEND send frame number 0
<snip />
May 16 12:59:26.60: [21357]: SEND send frame number 105
May 16 12:59:26.60: [21357]: DELAY 200 ms
May 16 12:59:26.79: [21357]: <-- [11:AT+FTM=146\r]
May 16 12:59:26.91: [21357]: --> [7:CONNECT]
May 16 12:59:26.91: [21357]: <-- data [1029]
<snip />
May 16 12:59:40.02: [21357]: <-- data [1036]
May 16 12:59:40.75: [21357]: <-- data [203]
May 16 12:59:40.75: [21357]: <-- data [2]
May 16 12:59:43.36: [21357]: --> [2:OK]
May 16 12:59:43.36: [21357]: DELAY 90 ms
May 16 12:59:43.45: [21357]: <-- [9:AT+FTH=3\r]
May 16 12:59:43.50: [21357]: --> [7:CONNECT]
May 16 12:59:43.50: [21357]: <-- data [7]
May 16 12:59:43.50: [21357]: <-- data [2]
May 16 12:59:44.82: [21357]: --> [2:OK]
May 16 12:59:44.82: [21357]: SEND send PPS (partial page signal)
May 16 12:59:44.82: [21357]: SEND send EOP (no more pages or documents)
May 16 12:59:44.82: [21357]: <-- [9:AT+FRH=3\r]
May 16 12:59:44.87: [21357]: --> [7:CONNECT]
May 16 12:59:46.08: [21357]: --> [2:OK]
May 16 12:59:46.08: [21357]: SEND recv RNR (receive not ready)
May 16 12:59:46.08: [21357]: DELAY 70 ms
May 16 12:59:46.15: [21357]: <-- [9:AT+FTH=3\r]
May 16 12:59:46.20: [21357]: --> [7:CONNECT]
May 16 12:59:46.20: [21357]: <-- data [3]
May 16 12:59:46.20: [21357]: <-- data [2]
May 16 12:59:47.40: [21357]: --> [2:OK]
May 16 12:59:47.40: [21357]: SEND send RR (receive ready)
May 16 12:59:47.40: [21357]: <-- [9:AT+FRH=3\r]
May 16 12:59:48.29: [21357]: --> [7:CONNECT]
May 16 12:59:49.50: [21357]: --> [2:OK]
May 16 12:59:49.50: [21357]: SEND recv MCF (message confirmation)
May 16 12:59:49.50: [21357]: SEND end page
May 16 12:59:49.50: [21357]: SEND FAX (000000027): FROM simon@faxserver 
TO 08707622312 (page 2 of 2 sent in 0:30)
May 16 12:59:49.50: [21357]: SEND FAX (000000027): FROM simon@faxserver 
TO 08707622312 (docq/doc21.ps;c1 sent in 0:30)
May 16 12:59:49.50: [21357]: <-- [9:AT+FTH=3\r]
May 16 12:59:49.58: [21357]: --> [7:CONNECT]
May 16 12:59:49.58: [21357]: <-- data [3]
May 16 12:59:49.58: [21357]: <-- data [2]
May 16 12:59:50.79: [21357]: --> [2:OK]
May 16 12:59:50.79: [21357]: <-- [5:ATH0\r]
May 16 12:59:51.08: [21357]: --> [2:OK]
May 16 12:59:51.08: [21357]: SESSION END

#####################################
/info file

supportsVRes:1
supports2DEncoding:yes
supportsMMR:yes
hasV34Trouble:no
supportsPostScript:no
supportsBatching:yes
calledBefore:yes
maxPageWidth:1728
maxPageLength:65535
maxSignallingRate:"14400"
minScanlineTime:"0ms"
remoteCSI:"PUMAONE.COM"
sendFailures:0
lastSendFailure:"COMREC invalid response received to PPS."
dialFailures:0
&pagingProtocol:"ixo"

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