[hylafax-users] modem (or faxgetty?) hangs "receiving from ..."

[Lucie <lucie@jvminfo.com>]

Hello,

I am experiencing a problem using hylafax on 2 machines with almost 
identical setups: they are running hylafax 4.1.5 sending and receiving 
with external sportster modems configured with the usr-rts setup. I have 
of course tried to change the setup to usr-xon but the problem persists. 
usr-2.0 is too buggy. I don't think it is relevant but the servers are 
running slackware 9.0 with kernel 2.4.20.

The problem is that the modem (or faxgetty?) hangs once in a while when 
receiving a job. I have to kill faxgetty to get the system back running. 
faxstat tells me that the modem is receiving, and the logs stop with a 
--> [5(or7):<garbage>] line, where i get 5 with the rtscts setup and 7 
with the xonxoff setup.

The strange part is that I get the problem once in a while only (no more 
than once or twice a week). There can be more than a hundred faxes 
coming in normally before I see this, and it happened on both machines. 
I don't have any error message anywhere either which complicates things 
a lot.

The logs don't seem to have anything relevant save for a MODEM <Timeout> 
and the last line where it apparently is receiving junk. faxgetty was 
hung everytime on "receiving from ..." until I killed it.

I'll create a script as a temporary solution but i would like to know 
whether anyone has seen that problem and would be kind enough to guide 
me so that i can fix this in a clean way.

Here are relevant logs. the modem here is a sportster 28800 identified 
as 3361:

May 13 15:10:53.66: [  386]: SESSION BEGIN 00000201 ...
May 13 15:10:53.66: [  386]: HylaFAX (tm) Version 4.1.5
May 13 15:10:53.66: [  386]: <-- [22:AT+FCLASS=1&H1&I0&R2A\r]
May 13 15:10:59.65: [  386]: --> [7:CONNECT]
May 13 15:10:59.65: [  386]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
May 13 15:10:59.65: [  386]: RECV FAX: begin

... (receives 5 pages) ...

May 13 15:12:51.02: [  386]: RECV FAX (00000201): from ..., page 5 in 
0:16, INF, 3.85 line/mm, 2-D MR, 9600 bit/s
May 13 15:12:51.02: [  386]: <-- data [3]
May 13 15:12:51.02: [  386]: <-- data [2]
May 13 15:12:52.19: [  386]: --> [2:OK]
May 13 15:12:52.19: [  386]: <-- [10:AT+FRM=96\r]
May 13 15:12:52.80: [  386]: --> [7:CONNECT]
May 13 15:12:52.80: [  386]: RECV: begin page
May 13 15:13:05.82: [  386]: RECV: 1099 total lines, 0 bad lines, 0 
consecutive bad lines
May 13 15:13:05.82: [  386]: RECV: end page
May 13 15:13:05.96: [  386]: --> [10:NO CARRIER]
May 13 15:13:05.96: [  386]: <-- [9:AT+FRH=3\r]
May 13 15:13:06.31: [  386]: --> [7:CONNECT]
May 13 15:13:07.04: [  386]: --> [2:OK]
May 13 15:13:07.04: [  386]: RECV recv MPS (more pages, same document)
May 13 15:13:07.04: [  386]: <-- [9:AT+FRS=7\r]
May 13 15:13:07.15: [  386]: --> [2:OK]
May 13 15:13:07.15: [  386]: <-- [9:AT+FTH=3\r]
May 13 15:13:37.15: [  386]: MODEM <Timeout>
May 13 15:13:37.15: [  386]: RECV send MCF (message confirmation)
May 13 15:13:37.15: [  386]: RECV FAX (00000201): from ..., page 6 in 
0:46, INF, 3.85 line/mm, 2-D MR, 9600 bit/s
May 13 15:13:37.15: [  386]: <-- data [3]
May 13 15:13:37.15: [  386]: <-- data [2]
May 13 15:13:39.70: [  386]: --> [5:ÿ?]


Other instances (actually all of them), this time on a sportster 56k 
identified as 5601:

Apr 29 15:36:40.48: [  389]: SESSION BEGIN 00000094 ...
Apr 29 15:36:40.48: [  389]: HylaFAX (tm) Version 4.1.5
Apr 29 15:36:40.48: [  389]: <-- [13:AT+FCLASS=1A\r]
Apr 29 15:36:46.03: [  389]: --> [7:CONNECT]
Apr 29 15:36:46.03: [  389]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Apr 29 15:36:46.03: [  389]: RECV FAX: begin
...
Apr 29 15:37:35.91: [  389]: MODEM <Timeout>
Apr 29 15:37:35.91: [  389]: RECV send MCF (message confirmation)
Apr 29 15:37:35.91: [  389]: RECV FAX (00000094): from 514 499 1071, 
page 1 in 0:42, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
Apr 29 15:37:35.91: [  389]: <-- data [3]
Apr 29 15:37:35.91: [  389]: <-- data [2]
Apr 29 15:37:38.46: [  389]: --> [7:ÿ?Bþ]
Apr 30 09:38:43.44: [  389]: CLOSE /dev/ttyS0

May 02 13:36:36.52: [  442]: SESSION BEGIN 00000104 ...
May 02 13:36:36.53: [  442]: HylaFAX (tm) Version 4.1.5
May 02 13:36:36.53: [  442]: <-- [13:AT+FCLASS=1A\r]
May 02 13:36:42.08: [  442]: --> [7:CONNECT]
May 02 13:36:42.08: [  442]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
May 02 13:36:42.08: [  442]: RECV FAX: begin
...
May 02 13:38:35.77: [  442]: MODEM <Timeout>
May 02 13:38:35.77: [  442]: RECV send MCF (message confirmation)
May 02 13:38:35.77: [  442]: RECV FAX (00000104): from 514 499 1071, 
page 4 in 0:51, INF, 3.85 line/mm, 2-D MR, 14400 bit/s
May 02 13:38:35.77: [  442]: <-- data [3]
May 02 13:38:35.77: [  442]: <-- data [2]
May 02 13:38:38.32: [  442]: --> [7:ÿ?Bú]

May 12 19:42:46.52: [  389]: SESSION BEGIN 00000142 ...
May 12 19:42:46.52: [  389]: HylaFAX (tm) Version 4.1.5
May 12 19:42:46.52: [  389]: <-- [22:AT+FCLASS=1&H1&I0&R2A\r]
May 12 19:42:52.08: [  389]: --> [7:CONNECT]
May 12 19:42:52.08: [  389]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
May 12 19:42:52.08: [  389]: RECV FAX: begin
...
May 12 19:44:26.16: [  389]: RECV recv MPS (more pages, same document)
May 12 19:44:26.16: [  389]: <-- [9:AT+FRS=7\r]
May 12 19:44:26.27: [  389]: --> [2:OK]
May 12 19:44:26.27: [  389]: <-- [9:AT+FTH=3\r]
May 12 19:44:56.27: [  389]: MODEM <Timeout>
May 12 19:44:56.27: [  389]: RECV send MCF (message confirmation)
May 12 19:44:56.27: [  389]: RECV FAX (00000142): from <UNSPECIFIED>, 
page 4 in 0:50, INF, 7.7 line/mm, 2-D MR, 14400 bit/s
May 12 19:44:56.27: [  389]: <-- data [3]
May 12 19:44:56.27: [  389]: <-- data [2]
May 12 19:44:58.82: [  389]: --> [5:ÿ?]

these are the only instances of timeout for this modem.


____________________ 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@hylafax.org < /dev/null
  *To learn about commercial HylaFAX(tm) support, mail sales@hylafax.org.*