[hylafax-users] Fax stopped working

[Ross Boylan <RossBoylan@stanfordalumni.org>]

Although I have faxed successfully from my machine in the past
(including using HylaFax), recently things have not worked.  It's
probably been a few months since I last tried.

I've tried at least 3 different fax numbers, but I seem to keep
getting errors like
No response to EOP repeated 3 times  or
No response to MPS repeated 3 times

In my last attempt, the recipient told me she got the cover page 3
times, but nothing more.  I don't know if the whole cover made it.
That job failed with an MPS error.

While my software environment has been changing, I don't think my
HylaFax server has.  Nor have we done anything with our phone lines,
though they have always been a little marginal.

If there is a way to fix or diagnose this problem further, I'd like to
try.  I've been working on some other fax problems (client side).  Now
that I think I've fixed them, it's disappointing to find I can't fax
at all!  On the other hand, I have a sinking feeling it might be a
hardware problem, though I don't know if it's the line or the card.

Thanks for any help.

Some details follow:
-------------------------------------------------
My modem is U.S. Robotics 56K Voice INT, model 5685. I don't
know how to check the firmware version but it's an ISA PNP modem that's
2-3 years old.  It's not a Courier or a Sporster, but it was supposed
to be good quality.  I've noticed the FAQ dissing the quality of US
Robotics modems, but it's what I've got.

Hylafax-server 4.1.1-1.1 on a Debian/testing system with AMD
processor.  It has lots of peripherals and interrupts are scarce.
This version appears to be after the changes identified in
http://bugs.hylafax.org/bugzilla/show_bug.cgi?id=185, which sounded
related.

My last failure log:
Jul 16 16:56:50.31: [ 7119]: SESSION BEGIN 00000058 14154766153
Jul 16 16:56:50.31: [ 7119]: HylaFAX (tm) Version 4.1.1
Jul 16 16:56:50.31: [ 7119]: SEND FAX: JOB 59 DEST 476-6153 COMMID 00000058 DEVICE '/dev/ttyS2'
Jul 16 16:56:58.48: [ 7119]: STATE CHANGE: RUNNING -> SENDING
Jul 16 16:58:03.47: [ 7119]: SEND: No response to MPS repeated 3 times; Giving up after 3 attempts to send same page "docq/doc59.cover;31", dirnum 0
Jul 16 16:58:03.58: [ 7119]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Jul 16 16:58:03.58: [ 7119]: SESSION END


And from the syslog (it was trying two different numbers):
Jul 16 16:55:21 wheat FaxGetty[854]: ANSWER: Can not lock modem device
Jul 16 16:55:21 wheat FaxGetty[854]: STATE CHANGE: RUNNING -> LOCKWAIT (timeout 30)
Jul 16 16:55:21 wheat FaxQueuer[582]: FIFO RECV "+ttyS2:U"
Jul 16 16:55:21 wheat FaxQueuer[582]: MODEM ttyS2: BUSY
Jul 16 16:55:21 wheat FaxQueuer[582]: JOB 59 (active dest +14154766153 pri 126 tts 0:00 killtime 2:53:47): CMD DONE: exit status 0
Jul 16 16:55:21 wheat FaxQueuer[582]: JOB 59 (sleeping dest +14154766153 pri 125 tts 0:00 killtime 2:53:47): SEND INCOMPLETE: requeue for 1:00; No response to MPS repeated 3 times
Jul 16 16:55:21 wheat FaxQueuer[582]: JOB 59 (sleeping dest +14154766153 pri 125 tts 0:00 killtime 2:53:47): SLEEP FOR 1:00
Jul 16 16:55:21 wheat FaxQueuer[582]: NOTIFY: bin/notify "sendq/q59" "requeued" "" "16:56"
Jul 16 16:55:22 wheat FaxQueuer[582]: JOB 58 (ready dest +19162290465 pri 126 tts 0:00 killtime 2:53:46): PROCESS
Jul 16 16:55:22 wheat FaxQueuer[582]: JOB 58 (active dest +19162290465 pri 126 tts 0:00 killtime 2:53:46): ACTIVE
Jul 16 16:55:22 wheat FaxQueuer[582]: JOB 58 (active dest +19162290465 pri 126 tts 0:00 killtime 2:53:46): CMD START /usr/sbin/faxsend -m ttyS2 sendq/q58 (PID 7099)
Jul 16 16:55:34 wheat FaxSend[7099]: MODEM U.S. ROBOTICS 56K VOICE /
Jul 16 16:55:35 wheat FaxSend[7099]: STATE CHANGE: BASE -> RUNNING
Jul 16 16:55:35 wheat FaxSend[7099]: SEND FAX: JOB 58 DEST 1 916 229-0465 COMMID 00000057 DEVICE '/dev/ttyS2'
Jul 16 16:55:45 wheat FaxQueuer[582]: FIFO RECV "*58:c"
Jul 16 16:55:59 wheat FaxQueuer[582]: FIFO RECV "*58:C"
Jul 16 16:56:21 wheat FaxQueuer[582]: JOB 59 (ready dest +14154766153 pri 125 tts 0:00 killtime 2:52:47): READY
Jul 16 16:56:21 wheat FaxQueuer[582]: JOB 59 (ready dest +14154766153 pri 125 tts 0:00 killtime 2:52:47): PROCESS
Jul 16 16:56:21 wheat FaxQueuer[582]: JOB 59 (ready dest +14154766153 pri 125 tts 0:00 killtime 2:52:47): No assignable modem located
Jul 16 16:56:37 wheat FaxQueuer[582]: JOB 58 (active dest +19162290465 pri 126 tts 0:00 killtime 2:52:31): CMD DONE: exit status 0
Jul 16 16:56:37 wheat FaxQueuer[582]: JOB 58 (sleeping dest +19162290465 pri 125 tts 0:00 killtime 2:52:31): SEND INCOMPLETE: requeue for 1:00; No response to MPS repeated 3 times
Jul 16 16:56:37 wheat FaxQueuer[582]: JOB 58 (sleeping dest +19162290465 pri 125 tts 0:00 killtime 2:52:31): SLEEP FOR 1:00
Jul 16 16:56:37 wheat FaxQueuer[582]: NOTIFY: bin/notify "sendq/q58" "requeued" "" "16:57"
Jul 16 16:56:37 wheat FaxQueuer[582]: JOB 59 (ready dest +14154766153 pri 125 tts 0:00 killtime 2:52:31): PROCESS
Jul 16 16:56:37 wheat FaxQueuer[582]: JOB 59 (active dest +14154766153 pri 125 tts 0:00 killtime 2:52:31): ACTIVE
Jul 16 16:56:37 wheat FaxQueuer[582]: JOB 59 (active dest +14154766153 pri 125 tts 0:00 killtime 2:52:31): CMD START /usr/sbin/faxsend -m ttyS2 sendq/q59 (PID 7119)
Jul 16 16:56:50 wheat FaxSend[7119]: MODEM U.S. ROBOTICS 56K VOICE /
Jul 16 16:56:50 wheat FaxSend[7119]: STATE CHANGE: BASE -> RUNNING
Jul 16 16:56:50 wheat FaxSend[7119]: SEND FAX: JOB 59 DEST 476-6153 COMMID 00000058 DEVICE '/dev/ttyS2'
Jul 16 16:57:00 wheat FaxQueuer[582]: FIFO RECV "*59:c"
Jul 16 16:57:21 wheat FaxQueuer[582]: FIFO RECV "*59:C"
Jul 16 16:57:37 wheat FaxQueuer[582]: JOB 58 (ready dest +19162290465 pri 125 tts 0:00 killtime 2:51:31): READY
Jul 16 16:57:37 wheat FaxQueuer[582]: JOB 58 (ready dest +19162290465 pri 125 tts 0:00 killtime 2:51:31): PROCESS
Jul 16 16:57:37 wheat FaxQueuer[582]: JOB 58 (ready dest +19162290465 pri 125 tts 0:00 killtime 2:51:31): No assignable modem located
Jul 16 16:58:03 wheat FaxSend[7119]: SEND: No response to MPS repeated 3 times; Giving up after 3 attempts to send same page "docq/doc59.cover;31", dirnum 0
Jul 16 16:58:03 wheat FaxQueuer[582]: JOB 59 (active dest +14154766153 pri 125 tts 0:00 killtime 2:51:05): CMD DONE: exit status 0x100
Jul 16 16:58:03 wheat FaxQueuer[582]: NOTIFY: bin/notify "doneq/q59" "failed" "1:26"
Jul 16 16:58:03 wheat FaxQueuer[582]: JOB 59 (failed dest +14154766153 pri 125 tts 0:00 killtime 2:51:05): SEND DONE: 1:26
Jul 16 16:58:03 wheat FaxQueuer[582]: JOB 59 (failed dest +14154766153 pri 125 tts 0:00 killtime 2:51:05): DEAD
Jul 16 16:58:03 wheat FaxQueuer[582]: JOB 58 (ready dest +19162290465 pri 125 tts 0:00 killtime 2:51:05): PROCESS





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