FreeBSD AutoPPP and mgetty problem

Kevin Hunt (kthunt@ainet.com)
Sat, 29 May 1999 17:47:49 -0700
Messages sorted by:[ date ][ thread ][ subject ][ author ]
I hope someone can even give me a suggestion on what might be going wrong...

        I am trying to set-up a couple of modems (USR's - external) for a
customer on a FreeBSD 3.0 box. They are going to be used only for dial-in's
to the computer to check mail and such using PPP. The client's will be
win9x laptops using Dial-up Networking.
        I'm not a unix guru by any means...I'm somewhere lower then a full
sys admin; I normally work through terminal servers and radius so this is
new to me to set up but I get to figure it out.
        I have mgetty installed with the -DAUTO_PPP set. And it does answer
the phone and gives the login: prompt. I have the devices set-up, the
ppp.conf's, etc... set-up according to instructions at FreeBSD.org using
their scripts and such.

If I try to use Win9x's dial-up networking to log in then it stops at the:
        05/29 17:07:01 aa1   getlogname (AUTO_PPP), read:
line and sits there. The dial-up networking will have thrown up a 'cannot
negotiate a network protocol...' at that time.

*** The below log is from dialing in with a terminal program.
*** Here is the mgetty log file entries for this call (debug 9):
05/29 17:05:01 aa1  check for lockfiles
05/29 17:05:01 aa1   checklock: no active process has lock, will remove
05/29 17:05:01 aa1  locking the line
05/29 17:05:01 aa1   makelock(cuaa1) called
05/29 17:05:01 aa1   do_makelock: lock=3D'/var/spool/lock/LCK..cuaa1'
05/29 17:05:01 aa1   lock made
05/29 17:05:04 aa1   tio_get_rs232_lines: status: RTS CTS DSR DTR
05/29 17:05:04 aa1  lowering DTR to reset Modem
05/29 17:05:04 aa1   tss: set speed to 19200 (45400)
05/29 17:05:04 aa1   tio_set_flow_control( HARD )
05/29 17:05:04 aa1   waiting for line to clear (VTIME), read:
05/29 17:05:04 aa1  send: ATZ[0d]
05/29 17:05:04 aa1  waiting for ``OK''
05/29 17:05:04 aa1   got: ATZ[0d]
05/29 17:05:04 aa1    CND: ATZ[0d][0a]OK ** found **
05/29 17:05:04 aa1  send: AT&C1&D2&H1&I0&R2&B1&W[0d]
05/29 17:05:04 aa1  waiting for ``OK''
05/29 17:05:04 aa1   got: [0d]
05/29 17:05:04 aa1    CND: OK[0a]AT&C1&D2&H1&I0&R2&B1&W[0d]
05/29 17:05:04 aa1    CND: AT&C1&D2&H1&I0&R2&B1&W[0d][0a]OK ** found **
05/29 17:05:05 aa1   waiting for line to clear (VTIME), read: [0d][0a]
05/29 17:05:05 aa1   removing lock file
05/29 17:05:05 aa1  waiting...
05/29 17:06:49 aa1    select returned 1
05/29 17:06:49 aa1   checking lockfiles, locking the line
05/29 17:06:49 aa1   makelock(cuaa1) called
05/29 17:06:49 aa1   do_makelock: lock=3D'/var/spool/lock/LCK..cuaa1'
05/29 17:06:49 aa1   lock made
05/29 17:06:49 aa1  wfr: waiting for ``RING''
05/29 17:06:49 aa1   got: [0d][0a]RING[0d]
05/29 17:06:49 aa1    CND: RING
05/29 17:06:49 aa1   wfr: rc=3D0, drn=3D0
05/29 17:06:49 aa1    CND: check no: 'none'
05/29 17:06:49 aa1  send: ATA[0d]
05/29 17:06:49 aa1  waiting for ``CONNECT''
05/29 17:06:49 aa1   got: ATA[0d]
05/29 17:06:49 aa1    CND: OKATA[0d][0a]CONNECT ** found **
05/29 17:07:01 aa1  send:
05/29 17:07:01 aa1  waiting for ``_''
05/29 17:07:01 aa1   got:  19200/ARQ/V34/LAPM/V42BIS[0d]
05/29 17:07:01 aa1    CND: CONNECT 19200/ARQ/V34/LAPM/V42BIS
05/29 17:07:01 aa1    CND: found: 19200/ARQ/V34/LAPM/V42BIS ** found **
05/29 17:07:01 aa1   waiting for line to clear (VTIME), read: [0a]
05/29 17:07:01 aa1   utmp + wtmp entry made
05/29 17:07:01 aa1   tio_set_flow_control( HARD )
05/29 17:07:01 aa1   print welcome banner (/etc/issue)
05/29 17:07:01 aa1   getlogname (AUTO_PPP), read:ppp[0d]
05/29 17:07:04 aa1   input finished with '\r', setting ICRNL ONLCR
05/29 17:07:04 aa1   tio_get_rs232_lines: status: RTS CTS DSR DTR DCD
05/29 17:07:04 aa1    login: use login config file
/usr/local/etc/mgetty+sendfax/login.config
05/29 17:07:04 aa1  login: '/usr/local/etc/mgetty+sendfax/login.config'
must be root/0600: Invalid argument
05/29 17:07:04 aa1   login: fall back to /usr/bin/login
05/29 17:07:04 aa1   calling login: cmd=3D'/usr/bin/login', argv[]=3D'login=
 ppp'
05/29 17:07:04 ##### data dev=3Dcuaa1, pid=3D23693, caller=3D'none',
conn=3D'19200/ARQ/V34/LAPM/V42BIS', name=3D'', cmd=3D
'/usr/bin/login', user=3D'ppp'

05/29 17:07:04 aa1   setenv: 'CALLER_ID=3Dnone'
05/29 17:07:04 aa1   setenv: 'CONNECT=3D19200/ARQ/V34/LAPM/V42BIS'
--
05/29 17:07:20 aa1  mgetty: experimental test release 1.1.19-Nov24
05/29 17:07:20 aa1  check for lockfiles
05/29 17:07:20 aa1   checklock: no active process has lock, will remove
05/29 17:07:20 aa1  locking the line
05/29 17:07:2=F2 aa1   makelock(cuaa1) called
**********************************************************************

*** Here is the entry for the terminal call from the system log:
May 29 17:07:20 mail login: login on cuaa1 as ppp
May 29 17:07:20 mail ppp[23693]: Warning: Label pap rejected -direct
connection: User access denied
**********************************************************************

It generates the 'login.conf' error in the mgetty log as soon as the
username is entered and CR is hit.
Any ideas or do you want to see some more files?

Thank you for any help

<------------------------------------------------>

Kevin Hunt - Website Programming
    kthunt@ainet.com

Technical Support - support@ainet.com

Phone: 209-549-8333
Fax:     209-549-8344