Trouble communicating with my modem

[Jack Burton <jackb@pgw.picker.com>]

I'm VERY New to Hlyafax.  I am trying to get hylafax (4.0pl1) going on a 
Dec Alpha running DU 3.2d.  I can connect to and dial out from my modem
via 'cu', but have problems with the hlafax sw.  The modem is a
USRobitics 33.6 Fax/Modem.

Can anyone help me?

I tried sending a Fax:

sendfax -d 5884595 /tmp/file1
request id is 1 (group id 1) for host localhost (1 file)
-----------------------------------------------------------

faxstat -s
HylaFAX scheduler on pgw6: Running

JID  Pri S  Owner Number       Pages Dials     TTS Status
1    127 W  jackb 5884595       0:0   0:12         
-----------------------------------------------------------

ps -ef | grep fax 
uucp       819     1  0.0 11:44:16 ??           0:00.05 /usr/local/sbin/faxq
root       948   819  0.0 11:51:22 ??           0:00.13 faxsend -m tty00 sendq/
root       978   856  0.0 11:54:24 ttyp7        0:00.00 grep fax
------------------------------------------------------------------------------

faxstat -s 
HylaFAX scheduler on pgw6: Running
Modem tty00 (+1.704.588.4595]): Waiting for modem to come ready

JID  Pri S  Owner Number       Pages Dials     TTS Status
1    126 S  jackb 5884595       0:2   1:12   17:00 Unspecified Transmit Phas

******************************************************************************* 
 
I'm getting the following logged via the syslog daemon

Jan 30 11:18:03 pgw6 mountd[347]: startup
Jan 30 11:18:09 pgw6 popd[508]: starting
Jan 30 11:44:16 pgw6 FaxQueuer[819]: HylaFAX (tm) Version 4.0pl1
Jan 30 11:44:16 pgw6 FaxQueuer[819]: Copyright (c) 1990-1996 Sam Leffler
Jan 30 11:44:16 pgw6 FaxQueuer[819]: Copyright (c) 1991-1996 Silicon Graphics, I
nc.
Jan 30 11:45:43 pgw6 FaxQueuer[819]: SUBMIT JOB 1
Jan 30 11:51:30 pgw6 FaxSend[948]: MODEM USROBOTICS SPORTSTER V.34+ FAX /
Jan 30 11:51:30 pgw6 FaxSend[948]: SEND FAX: JOB 1 DEST 5884595 COMMID 00000002
Jan 30 12:00:38 pgw6 FaxSend[1034]: MODEM USROBOTICS SPORTSTER V.34+ FAX /
Jan 30 12:00:38 pgw6 FaxSend[1034]: SEND FAX: JOB 1 DEST 5884595 COMMID 00000003
Jan 30 12:09:52 pgw6 FaxSend[1078]: MODEM USROBOTICS SPORTSTER V.34+ FAX /
Jan 30 12:09:53 pgw6 FaxSend[1078]: SEND FAX: JOB 1 DEST 5884595 COMMID 00000004
Jan 30 12:13:53 pgw6 FaxSend[1078]: SEND: Unspecified Transmit Phase D error, in
cluding +FPHCTO timeout between data and +FET command; Giving up after 3 attempt
s to send same page "docq/doc1.cover;30", dirnum 0
Jan 30 12:13:59 pgw6 FaxQueuer[819]: NOTIFY: bin/notify "doneq/q1" "failed" "4:1
********************************************************************************

The logfiles in /usr/var/spool/fax/log/c0000000* look like the following:


Jan 30 12:09:53.19: [ 1078]: SESSION BEGIN 00000004 17045884595
Jan 30 12:09:53.19: [ 1078]: SEND FAX: JOB 1 DEST 5884595 COMMID 00000004
Jan 30 12:09:53.19: [ 1078]: DELAY 2600 ms
Jan 30 12:09:55.79: [ 1078]: <-- [17:ATE0V1Q0X4S0=0H0\r]
Jan 30 12:09:55.92: [ 1078]: --> [16:ATE0V1Q0X4S0=0H0]
Jan 30 12:09:55.92: [ 1078]: --> [2:OK]
Jan 30 12:09:55.92: [ 1078]: <-- [32:ATS8=2S7=60&H1&I0&R2S13=1&D2&C1\r]
Jan 30 12:09:56.06: [ 1078]: --> [2:OK]
Jan 30 12:09:56.06: [ 1078]: <-- [14:AT+FCLASS=2.0\r]
Jan 30 12:09:56.19: [ 1078]: --> [2:OK]
Jan 30 12:09:56.19: [ 1078]: <-- [9:AT+FLO=2\r]
Jan 30 12:09:56.32: [ 1078]: --> [2:OK]
Jan 30 12:09:56.32: [ 1078]: <-- [9:AT+FPP=0\r]
Jan 30 12:09:56.45: [ 1078]: --> [2:OK]
Jan 30 12:09:56.45: [ 1078]: <-- [9:AT+FBO=0\r]
Jan 30 12:09:56.58: [ 1078]: --> [2:OK]
Jan 30 12:09:56.58: [ 1078]: <-- [10:AT+FCT=30\r]
Jan 30 12:09:56.71: [ 1078]: --> [2:OK]
Jan 30 12:09:56.71: [ 1078]: <-- [15:AT+FNR=1,1,1,1\r]
Jan 30 12:09:56.84: [ 1078]: --> [2:OK]
Jan 30 12:09:56.84: [ 1078]: <-- [9:AT+FIE=0\r]
Jan 30 12:09:56.97: [ 1078]: --> [2:OK]
Jan 30 12:09:56.97: [ 1078]: <-- [23:AT+FCC=1,5,2,2,0,0,0,0\r]
Jan 30 12:09:57.11: [ 1078]: --> [2:OK]
Jan 30 12:09:57.11: [ 1078]: <-- [5:ATM0\r]
Jan 30 12:09:57.23: [ 1078]: --> [2:OK]
Jan 30 12:09:57.25: [ 1078]: <-- [14:AT+FCLASS=2.0\r]
Jan 30 12:09:57.48: [ 1078]: --> [2:OK]
Jan 30 12:09:57.48: [ 1078]: <-- [9:AT+FLO=2\r]
Jan 30 12:09:57.71: [ 1078]: --> [2:OK]
Jan 30 12:09:57.71: [ 1078]: <-- [9:AT+FPP=0\r]
Jan 30 12:09:57.93: [ 1078]: --> [2:OK]
Jan 30 12:09:57.93: [ 1078]: <-- [9:AT+FBO=0\r]
Jan 30 12:09:58.16: [ 1078]: --> [2:OK]
Jan 30 12:09:58.16: [ 1078]: <-- [10:AT+FCT=30\r]
Jan 30 12:09:58.39: [ 1078]: --> [2:OK]
Jan 30 12:09:58.39: [ 1078]: <-- [15:AT+FNR=1,1,1,1\r]
Jan 30 12:09:58.63: [ 1078]: --> [2:OK]
Jan 30 12:09:58.63: [ 1078]: <-- [9:AT+FIE=0\r]
Jan 30 12:09:58.85: [ 1078]: --> [2:OK]
Jan 30 12:09:58.85: [ 1078]: <-- [23:AT+FCC=1,5,2,2,0,0,0,0\r]
Jan 30 12:09:59.09: [ 1078]: --> [2:OK]
Jan 30 12:09:59.09: [ 1078]: <-- [25:AT+FLI="clt2.picker.com"\r]
Jan 30 12:09:59.32: [ 1078]: --> [2:OK]
Jan 30 12:09:59.33: [ 1078]: DIAL 5884595
Jan 30 12:09:59.33: [ 1078]: <-- [12:ATDT5884595\r]
Jan 30 12:10:10.26: [ 1078]: --> [4:+FCO]
Jan 30 12:10:13.29: [ 1078]: --> [67:+FNF:0000091A086D7045884595FFFFFFFFFFFFFF01
19020A100182013000000069]
Jan 30 12:10:13.29: [ 1078]: REMOTE NSF "0000091A086D7045884595FFFFFFFFFFFFFF011
9020A100182013000000069"
Jan 30 12:10:13.29: [ 1078]: --> [27:+FCI:"        704 588 4595"]
Jan 30 12:10:13.29: [ 1078]: REMOTE CSI "704 588 4595"
Jan 30 12:10:13.29: [ 1078]: --> [20:+FIS:1,5,0,2,1,0,0,1]
Jan 30 12:10:13.39: [ 1078]: --> [2:OK]
Jan 30 12:10:13.39: [ 1078]: REMOTE best rate 14400 bit/s
Jan 30 12:10:13.39: [ 1078]: REMOTE max page width 1728 pixels in 215 mm
Jan 30 12:10:13.39: [ 1078]: REMOTE max unlimited page length 
Jan 30 12:10:13.39: [ 1078]: REMOTE best vres 7.7 line/mm
Jan 30 12:10:13.39: [ 1078]: REMOTE best format 2-D MR
Jan 30 12:10:13.39: [ 1078]: REMOTE best 5 ms/scanline
Jan 30 12:10:13.39: [ 1078]: USE 14400 bit/s
Jan 30 12:10:13.39: [ 1078]: USE 5 ms/scanline
Jan 30 12:10:13.39: [ 1078]: SEND file "docq/doc1.cover;30"
Jan 30 12:10:13.39: [ 1078]: USE page width 1728 pixels in 215 mm
Jan 30 12:10:13.39: [ 1078]: USE unlimited page length 
Jan 30 12:10:13.39: [ 1078]: USE 3.85 line/mm
Jan 30 12:10:13.39: [ 1078]: USE 1-D MR
Jan 30 12:10:13.39: [ 1078]: <-- [23:AT+FIS=0,5,0,2,0,0,0,1\r]
Jan 30 12:10:13.63: [ 1078]: --> [2:OK]
Jan 30 12:10:13.63: [ 1078]: <-- [7:AT+FDT\r]
Jan 30 12:10:13.89: [ 1078]: --> [20:+FCS:0,5,0,2,0,0,0,1]
Jan 30 12:10:20.54: [ 1078]: --> [7:CONNECT]
Jan 30 12:10:20.54: [ 1078]: SEND begin page
Jan 30 12:10:20.54: [ 1078]: <-- data [1033]
Jan 30 12:10:20.54: [ 1078]: <-- data [1032]
Jan 30 12:10:20.55: [ 1078]: <-- data [1028]
Jan 30 12:10:21.02: [ 1078]: <-- data [1045]
Jan 30 12:10:21.49: [ 1078]: <-- data [1026]
Jan 30 12:10:21.49: [ 1078]: <-- data [1039]
Jan 30 12:10:21.98: [ 1078]: <-- data [1042]
Jan 30 12:10:21.98: [ 1078]: <-- data [1055]
Jan 30 12:10:22.47: [ 1078]: <-- data [1049]
Jan 30 12:10:22.47: [ 1078]: <-- data [1053]
Jan 30 12:10:22.97: [ 1078]: <-- data [1050]
Jan 30 12:10:23.46: [ 1078]: <-- data [1026]
Jan 30 12:10:23.46: [ 1078]: <-- data [765]
Jan 30 12:10:23.46: [ 1078]: SENT 13053 bytes of data
Jan 30 12:10:23.46: [ 1078]: SEND 1D RTC
Jan 30 12:10:23.46: [ 1078]: <-- data [9]
Jan 30 12:10:23.46: [ 1078]: SEND end page
Jan 30 12:10:23.46: [ 1078]: SEND send MPS (more pages, same document)
Jan 30 12:10:23.46: [ 1078]: <-- data [2]
Jan 30 12:13:23.93: [ 1078]: REMOTE HANGUP: Unspecified Transmit Phase D error, 
including +FPHCTO timeout between data and +FET command (code 50)
Jan 30 12:13:23.93: [ 1078]: <-- [7:AT+FKS\r]
Jan 30 12:13:53.93: [ 1078]: MODEM <Timeout>
Jan 30 12:13:53.93: [ 1078]: SEND: Unspecified Transmit Phase D error, including
 +FPHCTO timeout between data and +FET command; Giving up after 3 attempts to se
nd same page "docq/doc1.cover;30", dirnum 0
Jan 30 12:13:53.93: [ 1078]: <-- [5:ATH0\r]
Jan 30 12:13:58.93: [ 1078]: MODEM <Timeout>
Jan 30 12:13:58.93: [ 1078]: SESSION END