Re: [hylafax-users] strange situation receiving faxes

[longbow <longbow@xxxxxx>]

hi lee!

ok, the session log for the usr modem:

Mar 17 16:49:40.48: [ 9165]: SESSION BEGIN 000001184 49xxxxxxxx
Mar 17 16:49:40.48: [ 9165]: HylaFAX (tm) Version 4.3.0
Mar 17 16:49:40.48: [ 9165]: DELAY 100 ms
Mar 17 16:49:40.58: [ 9165]: <-- [4:ATA\r]
Mar 17 16:49:46.49: [ 9165]: --> [4:+FCO]
Mar 17 16:49:46.49: [ 9165]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Mar 17 16:49:46.49: [ 9165]: RECV FAX: begin
Mar 17 16:49:48.49: [ 9165]: --> [27:+FTI:"                    "]
Mar 17 16:49:48.49: [ 9165]: REMOTE TSI ""
Mar 17 16:49:48.50: [ 9165]: --> [20:+FCS:1,5,0,2,0,0,0,3]
Mar 17 16:49:48.50: [ 9165]: REMOTE wants 14400 bit/s
Mar 17 16:49:48.50: [ 9165]: REMOTE wants A4 page width (215 mm)
Mar 17 16:49:48.50: [ 9165]: REMOTE wants unlimited page length
Mar 17 16:49:48.50: [ 9165]: REMOTE wants 7.7 line/mm
Mar 17 16:49:48.50: [ 9165]: REMOTE wants 1-D MH
Mar 17 16:49:48.51: [ 9165]: --> [2:OK]
Mar 17 16:49:48.51: [ 9165]: DELAY 100 ms
Mar 17 16:49:48.61: [ 9165]: <-- [7:AT+FDR\r]
Mar 17 16:49:55.60: [ 9165]: --> [7:CONNECT]
Mar 17 16:49:55.60: [ 9165]: RECV: begin page
Mar 17 16:49:55.60: [ 9165]: RECV: send trigger 022
Mar 17 16:49:55.60: [ 9165]: Copy quality checking performed by host
Mar 17 16:51:30.77: [ 9165]: MODEM TIMEOUT: reading from modem
Mar 17 16:51:30.77: [ 9165]: RECV: Missing EOL after 5 seconds
Mar 17 16:51:30.77: [ 9165]: REMOTE HANGUP: Missing EOL after 5 seconds 
(section 3.2/T.4) (code 91)
Mar 17 16:51:30.77: [ 9165]: RECV FAX (000001184): 
recvq/fax000000895.tif from , route to <unspecified>, 0 pages in 1:44
Mar 17 16:51:30.77: [ 9165]: RECV FAX: Missing EOL after 5 seconds 
(section 3.2/T.4)
Mar 17 16:51:30.77: [ 9165]: DELAY 100 ms
Mar 17 16:51:30.87: [ 9165]: <-- [7:AT+FKS\r]
Mar 17 16:52:00.88: [ 9165]: MODEM TIMEOUT: reading line from modem
Mar 17 16:52:00.88: [ 9165]: MODEM <Timeout>
Mar 17 16:52:00.88: [ 9165]: RECV FAX (000001184): session with 
terminated abnormally: Missing EOL after 5 seconds (section 3.2/T.4)
Mar 17 16:52:00.88: [ 9165]: RECV FAX: bin/faxrcvd 
"recvq/fax000000895.tif" "ttyS0" "000001184" "Missing EOL after 5 
seconds (section 3.2/T.4)"
Mar 17 16:52:00.88: [ 9165]: RECV FAX: end
Mar 17 16:52:00.88: [ 9165]: SESSION END

and here is the log of a failed elsa session:

Jun 03 21:41:44.56: [  504]: SESSION BEGIN 000001353 +49xxxxxxxxxxxx
Jun 03 21:41:44.56: [  504]: HylaFAX (tm) Version 5.2.2
Jun 03 21:41:44.56: [  504]: <-- [4:ATA\r]
Jun 03 21:41:53.16: [  504]: --> [4:+FCO]
Jun 03 21:41:53.16: [  504]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Jun 03 21:41:53.16: [  504]: RECV FAX: begin
Jun 03 21:41:56.88: [  504]: --> [27:+FTI:"                    "]
Jun 03 21:41:56.88: [  504]: REMOTE TSI ""
Jun 03 21:41:56.89: [  504]: --> [20:+FCS:0,3,0,2,0,0,0,3]
Jun 03 21:41:56.89: [  504]: REMOTE wants 9600 bit/s
Jun 03 21:41:56.89: [  504]: REMOTE wants A4 page width (215 mm)
Jun 03 21:41:56.89: [  504]: REMOTE wants unlimited page length
Jun 03 21:41:56.89: [  504]: REMOTE wants 3.85 line/mm
Jun 03 21:41:56.89: [  504]: REMOTE wants 1-D MH
Jun 03 21:41:56.89: [  504]: --> [2:OK]
Jun 03 21:41:56.89: [  504]: <-- [7:AT+FDR\r]
Jun 03 21:42:00.96: [  504]: --> [7:CONNECT]
Jun 03 21:42:00.96: [  504]: RECV: begin page
Jun 03 21:42:00.96: [  504]: RECV: send trigger 022
Jun 03 21:42:00.96: [  504]: Copy quality checking performed by modem
Jun 03 21:42:35.21: [  504]: RECV: 301 bytes of data, 10 total lines
Jun 03 21:42:35.22: [  504]: --> [16:+FPS:2,62,56,0,0]
Jun 03 21:42:36.46: [  504]: --> [6:+FET:2]
Jun 03 21:42:36.46: [  504]: RECV recv EOP (no more pages or documents)
Jun 03 21:42:36.46: [  504]: --> [5:ERROR]
Jun 03 21:42:36.46: [  504]: MODEM Command error
Jun 03 21:42:36.46: [  504]: RECV send RTN (retrain negative)
Jun 03 21:42:36.46: [  504]: <-- [7:AT+FDR\r]
Jun 03 21:42:39.63: [  504]: --> [7:+FHS:00]
Jun 03 21:42:39.63: [  504]: REMOTE HANGUP: Normal and proper end of 
connection (code 0)
Jun 03 21:42:39.65: [  504]: --> [2:OK]
Jun 03 21:42:39.65: [  504]: RECV keeping unconfirmed page
Jun 03 21:42:39.65: [  504]: RECV FAX (000001353): from , page 1 in 
0:00:42, INF, 3.85 line/mm, 1-D MH, 9600 bit/s
Jun 03 21:42:40.66: [  504]: RECV FAX: Normal and proper end of 
connection {E211}
Jun 03 21:42:40.66: [  504]: RECV FAX (000001353): 
recvq/fax000001057.tif from , subaddress <unspecified>, 1 pages in 0:00:46
Jun 03 21:42:40.66: [  504]: RECV FAX (000001353): session with 
terminated abnormally: Normal and proper end of connection {E211}
Jun 03 21:42:40.66: [  504]: RECV FAX: bin/faxrcvd 
'recvq/fax000001057.tif' 'ttyS0' '000001353' 'Normal and proper end of 
connection {E211}'
Jun 03 21:42:40.66: [  504]: RECV FAX: end
Jun 03 21:42:40.66: [  504]: SESSION END

please remember also the behaviour of the canon b820 fax when sending 
the first 2 pages faulty:

Jun 03 14:39:49.35: [  504]: SESSION BEGIN 000001338 +49xxxxxxxxxxx
Jun 03 14:39:49.35: [  504]: HylaFAX (tm) Version 5.2.2
Jun 03 14:39:49.35: [  504]: <-- [4:ATA\r]
Jun 03 14:39:57.93: [  504]: --> [4:+FCO]
Jun 03 14:39:57.93: [  504]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Jun 03 14:39:57.93: [  504]: RECV FAX: begin
Jun 03 14:40:01.65: [  504]: --> [27:+FTI:"                    "]
Jun 03 14:40:01.65: [  504]: REMOTE TSI ""
Jun 03 14:40:01.65: [  504]: --> [20:+FCS:0,3,0,2,0,0,0,3]
Jun 03 14:40:01.65: [  504]: REMOTE wants 9600 bit/s
Jun 03 14:40:01.65: [  504]: REMOTE wants A4 page width (215 mm)
Jun 03 14:40:01.65: [  504]: REMOTE wants unlimited page length
Jun 03 14:40:01.65: [  504]: REMOTE wants 3.85 line/mm
Jun 03 14:40:01.65: [  504]: REMOTE wants 1-D MH
Jun 03 14:40:01.65: [  504]: --> [2:OK]
Jun 03 14:40:01.65: [  504]: <-- [7:AT+FDR\r]
Jun 03 14:40:05.63: [  504]: --> [7:CONNECT]
Jun 03 14:40:05.63: [  504]: RECV: begin page
Jun 03 14:40:05.63: [  504]: RECV: send trigger 022
Jun 03 14:40:05.63: [  504]: <-- data [1]
Jun 03 14:40:05.63: [  504]: Copy quality checking performed by modem
Jun 03 14:41:00.38: [  504]: RECV: 423 bytes of data, 18 total lines
Jun 03 14:41:00.39: [  504]: --> [16:+FPS:2,A4,90,0,0]
Jun 03 14:41:01.65: [  504]: --> [6:+FET:0]
Jun 03 14:41:01.65: [  504]: RECV recv MPS (more pages, same document)
Jun 03 14:41:01.65: [  504]: --> [5:ERROR]
Jun 03 14:41:01.65: [  504]: MODEM Command error
Jun 03 14:41:01.65: [  504]: RECV send RTN (retrain negative)
Jun 03 14:41:01.65: [  504]: <-- [7:AT+FDR\r]
Jun 03 14:41:07.63: [  504]: --> [27:+FTI:"                    "]
Jun 03 14:41:07.63: [  504]: REMOTE TSI ""
Jun 03 14:41:07.64: [  504]: --> [20:+FCS:0,2,0,2,0,0,0,3]
Jun 03 14:41:07.64: [  504]: REMOTE wants 7200 bit/s
Jun 03 14:41:07.64: [  504]: REMOTE wants A4 page width (215 mm)
Jun 03 14:41:07.64: [  504]: REMOTE wants unlimited page length
Jun 03 14:41:07.64: [  504]: REMOTE wants 3.85 line/mm
Jun 03 14:41:07.64: [  504]: REMOTE wants 1-D MH
Jun 03 14:41:12.00: [  504]: --> [7:CONNECT]
Jun 03 14:41:12.00: [  504]: RECV: begin page
Jun 03 14:41:12.00: [  504]: RECV: send trigger 022
Jun 03 14:41:12.00: [  504]: <-- data [1]
Jun 03 14:41:12.00: [  504]: Copy quality checking performed by modem
Jun 03 14:42:02.49: [  504]: RECV: 2310 bytes of data, 81 total lines
Jun 03 14:42:02.50: [  504]: --> [16:+FPS:2,C8,73,0,0]
Jun 03 14:42:03.76: [  504]: --> [6:+FET:0]
Jun 03 14:42:03.76: [  504]: RECV recv MPS (more pages, same document)
Jun 03 14:42:03.76: [  504]: --> [5:ERROR]
Jun 03 14:42:03.76: [  504]: MODEM Command error
Jun 03 14:42:03.76: [  504]: RECV send RTN (retrain negative)
Jun 03 14:42:03.76: [  504]: <-- [7:AT+FDR\r]
Jun 03 14:42:10.38: [  504]: --> [27:+FTI:"                    "]
Jun 03 14:42:10.38: [  504]: REMOTE TSI ""
Jun 03 14:42:10.38: [  504]: --> [20:+FCS:0,1,0,2,0,0,0,3]
Jun 03 14:42:10.38: [  504]: REMOTE wants 4800 bit/s
Jun 03 14:42:10.38: [  504]: REMOTE wants A4 page width (215 mm)
Jun 03 14:42:10.38: [  504]: REMOTE wants unlimited page length
Jun 03 14:42:10.38: [  504]: REMOTE wants 3.85 line/mm
Jun 03 14:42:10.38: [  504]: REMOTE wants 1-D MH
Jun 03 14:42:15.45: [  504]: --> [7:CONNECT]
Jun 03 14:42:15.45: [  504]: RECV: begin page
Jun 03 14:42:15.45: [  504]: RECV: send trigger 022
Jun 03 14:42:15.45: [  504]: <-- data [1]
Jun 03 14:42:15.45: [  504]: Copy quality checking performed by modem
Jun 03 14:43:02.79: [  504]: RECV: 18378 bytes of data, 1143 total lines
Jun 03 14:43:02.82: [  504]: --> [16:+FPS:1,479,0,0,0]
Jun 03 14:43:04.10: [  504]: --> [6:+FET:0]
Jun 03 14:43:04.10: [  504]: RECV recv MPS (more pages, same document)
Jun 03 14:43:04.10: [  504]: --> [2:OK]
Jun 03 14:43:04.10: [  504]: RECV send MCF (message confirmation)
Jun 03 14:43:04.10: [  504]: RECV FAX (000001338): from , page 1 in 
0:01:00, INF, 3.85 line/mm, 1-D MH, 4800 bit/s
Jun 03 14:43:04.10: [  504]: <-- [7:AT+FDR\r]
Jun 03 14:43:08.22: [  504]: --> [7:CONNECT]
Jun 03 14:43:08.22: [  504]: RECV: begin page
Jun 03 14:43:08.22: [  504]: RECV: send trigger 022
Jun 03 14:43:08.22: [  504]: <-- data [1]
Jun 03 14:43:08.22: [  504]: Copy quality checking performed by modem
Jun 03 14:44:05.29: [  504]: RECV: 23206 bytes of data, 1143 total lines
Jun 03 14:44:05.48: [  504]: --> [16:+FPS:1,479,0,0,0]
Jun 03 14:44:06.75: [  504]: --> [6:+FET:0]
Jun 03 14:44:06.75: [  504]: RECV recv MPS (more pages, same document)
Jun 03 14:44:06.75: [  504]: --> [2:OK]
Jun 03 14:44:06.75: [  504]: RECV send MCF (message confirmation)
Jun 03 14:44:06.75: [  504]: <-- [7:AT+FDR\r]
Jun 03 14:44:06.75: [  504]: RECV FAX (000001338): from , page 2 in 
0:01:03, INF, 3.85 line/mm, 1-D MH, 4800 bit/s
...
Jun 03 14:47:49.40: [  504]: RECV FAX (000001338): from , page 6 in 
0:01:12, INF, 3.85 line/mm, 1-D MH, 4800 bit/s
Jun 03 14:47:50.40: [  504]: RECV FAX (000001338): 
recvq/fax000001044.tif from , subaddress <unspecified>, 6 pages in 0:07:52
Jun 03 14:47:50.41: [  504]: <-- [7:AT+FDR\r]
Jun 03 14:47:53.57: [  504]: --> [7:+FHS:00]
Jun 03 14:47:53.57: [  504]: REMOTE HANGUP: Normal and proper end of 
connection (code 0)
Jun 03 14:47:53.59: [  504]: --> [2:OK]
Jun 03 14:47:53.59: [  504]: RECV FAX: bin/faxrcvd 
'recvq/fax000001044.tif' 'ttyS0' '000001338' ''
Jun 03 14:47:53.59: [  504]: RECV FAX: end
Jun 03 14:47:53.59: [  504]: SESSION END

first page is started with 9600 bit/s (startspeed set in the fax by me 
to be sure that the pages are sent ok although there is some line 
disortion) then it switches down to 7200 bit/s and the pages that are 
sent ok with 4800 bit/s.

hope you can help me!

thx
wolfgang



Lee Howard wrote:
> Whenever discussing a fax session that fails it is important to provide 
> a session log.  So if you could provide session logs with the USR modems 
> and Elsa modem... all together would help make sense of things.
>
> Thanks,
>
> Lee.


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