Do not see any error, but No Fax in Spool either.

Philip Motteli (moetteli@monster.citeu.unige.ch)
Sat, 3 May 97 04:45:09 +0100


Hi out there


I just installed mgetty on my OpenStep 4.1 Intel with a Bullet E288 modem 
connected to.
Fortunately data connections (PPP) still works fine. But I can't receive 
faxes. At least I don't find them afterwards in FAX_SPOOL_IN (which is 
/usr/spool/fax/incoming) and I don't receive any mail either.
In the log I see only the error message about the DSR, that were off. It's 
just a warning, so I thought this is not the point. But I do not see any 
other.
Here's the log (at the end there's also a PPP session; but I don't know 
where this starts.):



05/03 04:00:56 dfa mgetty: official release 1.0.0
05/03 04:00:56 dfa mgetty.c compiled at Wed Apr 30 1997, 23:40:52 GMT+0100
05/03 04:00:56 dfa reading configuration data for port 'cudfa'
05/03 04:00:56 dfa conf lib: read: 'debug 8'
05/03 04:00:56 dfa conf lib: read: 'fax-id +41 22 839 21 00'
05/03 04:00:56 dfa conf lib: read: 'speed 38400'
05/03 04:00:56 dfa key: 'speed', type=0, flags=3, data=38400
05/03 04:00:56 dfa key: 'switchbd', type=0, flags=1, data=0
05/03 04:00:56 dfa key: 'direct', type=3, flags=1, data=FALSE
05/03 04:00:56 dfa key: 'blocking', type=3, flags=1, data=FALSE
05/03 04:00:56 dfa key: 'port-owner', type=1, flags=1, data=uucp
05/03 04:00:56 dfa key: 'port-group', type=1, flags=1, data=modem
05/03 04:00:56 dfa key: 'port-mode', type=0, flags=1, data=432
05/03 04:00:56 dfa key: 'toggle-dtr', type=3, flags=1, data=TRUE
05/03 04:00:56 dfa key: 'toggle-dtr-waittime', type=0, flags=1, data=500
05/03 04:00:56 dfa key: 'data-only', type=3, flags=1, data=FALSE
05/03 04:00:56 dfa key: 'fax-only', type=3, flags=1, data=FALSE
05/03 04:00:56 dfa key: 'modem-type', type=1, flags=1, data=auto
05/03 04:00:56 dfa key: 'init-chat', type=2, flags=1, data= \dATQ0V1H0 OK 
ATS0=0Q0&D3&C1 OK
\dATQ0V1H0 OK dfa key: 'force-init-chat', type=2, flags=1, data= 
\d\d\d\d+++\d\d\d
05/03 04:00:56 dfa key: 'modem-check-time', type=0, flags=1, data=3600
05/03 04:00:56 dfa key: 'rings', type=0, flags=1, data=1
05/03 04:00:56 dfa key: 'get-cnd-chat', type=2, flags=0, data=(empty)
05/03 04:00:56 dfa key: 'answer-chat', type=2, flags=1, data= ATA CONNECT \c
05/03 04:00:56 dfa key: 'answer-chat-timeout', type=0, flags=1, data=80
05/03 04:00:56 dfa key: 'autobauding', type=3, flags=1, data=FALSE
05/03 04:00:56 dfa key: 'ringback', type=3, flags=1, data=FALSE
05/03 04:00:56 dfa key: 'ringback-time', type=0, flags=1, data=30
05/03 04:00:56 dfa key: 'ignore-carrier', type=3, flags=1, data=FALSE
05/03 04:00:56 dfa key: 'issue-file', type=1, flags=1, data=/etc/issue
05/03 04:00:56 dfa key: 'prompt-waittime', type=0, flags=1, data=500
05/03 04:00:56 dfa key: 'login-prompt', type=1, flags=1, data=@!login:
05/03 04:00:56 dfa key: 'login-time', type=0, flags=0, data=(empty)
05/03 04:00:56 dfa key: 'fido-send-emsi', type=3, flags=1, data=TRUE
05/03 04:00:56 dfa key: 'fax-id', type=1, flags=3, data=+41 22 839 21 00
05/03 04:00:56 dfa key: 'fax-server-file', type=1, flags=0, data=(empty)
05/03 04:00:56 dfa key: 'diskspace', type=0, flags=1, data=1024
05/03 04:00:56 dfa key: 'notify', type=1, flags=1, data=moetteli
05/03 04:00:56 dfa key: 'fax-owner', type=1, flags=1, data=uucp
05/03 04:00:56 dfa key: 'fax-group', type=1, flags=0, data=(empty)
05/03 04:00:56 dfa key: 'fax-mode', type=0, flags=1, data=432
05/03 04:00:56 dfa key: 'debug', type=0, flags=2, data=8
05/03 04:00:56 dfa key: 'statistics-chat', type=2, flags=0, data=(empty)
05/03 04:00:56 dfa key: 'statistics-file', type=1, flags=0, data=(empty)
05/03 04:00:56 dfa key: 'gettydefs', type=1, flags=1, data=n
05/03 04:00:56 dfa key: 'term', type=1, flags=0, data=(empty)
05/03 04:00:56 dfa check for lockfiles
05/03 04:00:56 dfa checklock: no active process has lock, will remove
05/03 04:00:56 dfa locking the line
05/03 04:00:56 dfa makelock(cudfa) called
05/03 04:00:56 dfa do_makelock: lock='/usr/spool/uucp/LCK/LCK..cudfa'
05/03 04:00:57 dfa lock made
05/03 04:00:59 dfa tio_get_rs232_lines: status: RTS CTS DTR
05/03 04:00:59 dfa WARNING: DSR is off - modem turned off or bad cable?
05/03 04:00:59 dfa lowering DTR to reset Modem
05/03 04:01:00 dfa tss: set speed to 38400 (017)
05/03 04:01:00 dfa tio_set_flow_control( HARD )
05/03 04:01:00 dfa tio_set_flow_control: not yet implemented
05/03 04:01:00 dfa waiting for line to clear (select), read:
05/03 04:01:00 dfa select returned 0
05/03 04:01:00 dfa send: \dATQ0V1H0[0d]
05/03 04:01:01 dfa waiting for ``OK''
05/03 04:01:01 dfa got: ATQ0V1H0[0d]
05/03 04:01:01 dfa CND: ATQ0V1H0[0d][0a]OK ** found **
05/03 04:01:01 dfa send: ATS0=0Q0&D3&C1[0d]
05/03 04:01:01 dfa waiting for ``OK''
05/03 04:01:01 dfa got: [0d]
05/03 04:01:01 dfa CND: OK[0a]ATS0=0Q0&D3&C1[0d]
05/03 04:01:01 dfa CND: ATS0=0Q0&D3&C1[0d][0a]OK ** found **
05/03 04:01:01 dfa mdm_send: 'AT+FCLASS=2.0'
05/03 04:01:01 dfa got:AT+FCLASS=2.0[0d]
05/03 04:01:01 dfa mdm_command: string 'AT+FCLASS=2.0'
05/03 04:01:01 dfa got:[0d][0a]ERROR[0d]
05/03 04:01:01 dfa mdm_command: string 'ERROR' -> ERROR
05/03 04:01:01 dfa mdm_send: 'AT+FCLASS=2'
05/03 04:01:01 dfa got:[0a]AT+FCLASS=2[0d]
05/03 04:01:01 dfa mdm_command: string 'AT+FCLASS=2'
05/03 04:01:01 dfa got:[0d][0a]OK[0d]
05/03 04:01:01 dfa mdm_command: string 'OK' -> OK
05/03 04:01:01 dfa mdm_send: 'AT+FCLASS=0'
05/03 04:01:01 dfa got:[0a]AT+FCLASS=0[0d]
05/03 04:01:01 dfa mdm_command: string 'AT+FCLASS=0'
05/03 04:01:01 dfa got:[0d][0a]OK[0d]
05/03 04:01:01 dfa mdm_command: string 'OK' -> OK
05/03 04:01:01 dfa mdm_send: 'AT+FAA=1;+FCR=1'
05/03 04:01:01 dfa got:[0a]AT+FAA=1;+FCR=1[0d]
05/03 04:01:01 dfa mdm_command: string 'AT+FAA=1;+FCR=1'
05/03 04:01:01 dfa got:[0d][0a]OK[0d]
05/03 04:01:02 dfa mdm_command: string 'OK' -> OK
05/03 04:01:02 dfa mdm_send: 'AT+FBOR=0'
05/03 04:01:02 dfa got:[0a]AT+FBOR=0[0d]
05/03 04:01:02 dfa mdm_command: string 'AT+FBOR=0'
05/03 04:01:02 dfa got:[0d][0a]OK[0d]
05/03 04:01:02 dfa mdm_command: string 'OK' -> OK
05/03 04:01:02 dfa mdm_send: 'AT+FLID="+41 22 839 21 00"'
05/03 04:01:02 dfa got:[0a]AT+FLID="+41 22 839 21 00"[0d]
05/03 04:01:02 dfa mdm_command: string 'AT+FLID="+41 22 839 21 00"'
05/03 04:01:02 dfa got:[0d][0a]OK[0d]
05/03 04:01:02 dfa mdm_command: string 'OK' -> OK
05/03 04:01:02 dfa mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0'
05/03 04:01:02 dfa got:[0a]AT+FDCC=1,5,0,2,0,0,0,0[0d]
05/03 04:01:02 dfa mdm_command: string 'AT+FDCC=1,5,0,2,0,0,0,0'
05/03 04:01:02 dfa got:[0d][0a]OK[0d]
05/03 04:01:02 dfa mdm_command: string 'OK' -> OK
05/03 04:01:02 dfa waiting for line to clear (select), read:
05/03 04:01:02 dfa select returned 0
05/03 04:01:02 dfa removing lock file
05/03 04:01:02 dfa waiting...
05/03 04:03:15 dfa select returned 1
05/03 04:03:15 dfa checking lockfiles, locking the line
05/03 04:03:15 dfa makelock(cudfa) called
05/03 04:03:15 dfa do_makelock: lock='/usr/spool/uucp/LCK/LCK..cudfa'
05/03 04:03:15 dfa lock made
05/03 04:03:15 dfa waiting for ``RING''
05/03 04:03:15 dfa got: [0d]
05/03 04:03:20 dfa CND: OK[0a]RING ** found **
05/03 04:03:20 dfa send: ATA[0d]
05/03 04:03:20 dfa waiting for ``CONNECT''
05/03 04:03:20 dfa got: ATA[0d]
05/03 04:03:20 dfa CND: RINGATA[0d][0a]DATA[0d]
05/03 04:03:35 dfa CND: DATA[0a][0d][0a]CONNECT ** found **
05/03 04:03:36 dfa send:
05/03 04:03:36 dfa waiting for ``
''
05/03 04:03:36 dfa got: 38400[0d]
05/03 04:03:36 dfa CND: CONNECT 38400
05/03 04:03:36 dfa CND: found: 38400[0a] ** found **
05/03 04:03:36 dfa waiting for line to clear (select), read:
05/03 04:03:36 dfa select returned 0
05/03 04:03:37 dfa tio_set_flow_control( HARD )
05/03 04:03:37 dfa tio_set_flow_control: not yet implemented
05/03 04:03:37 dfa getlogname (no opts), read:ppp0[0d]
05/03 04:03:37 dfa input finished with '\r', setting ICRNL ONLCR
05/03 04:03:37 dfa tio_get_rs232_lines: status: RTS CTS DTR DCD
05/03 04:03:37 dfa login: use login config file 
/usr/local/etc/mgetty+sendfax/login.config
05/03 04:03:38 dfa match: user='ppp0', key=''
05/03 04:03:38 dfa match: user='ppp0', key='/FIDO/'
05/03 04:03:38 dfa match: user='ppp0', key=''
05/03 04:03:38 dfa match: user='ppp0', key=''
05/03 04:03:38 dfa match: user='ppp0', key='*'*** hit!
05/03 04:03:38 dfa calling login: cmd='/bin/login', argv[]='login ppp0'
05/03 04:03:38 ##### data dev=cudfa, pid=17105, caller=none, conn='38400', 
name='', cmd='/bin/login', user='ppp0'

05/03 04:03:38 dfa setenv: 'CALLER_ID=none'
.