ppp dialin problems: mgetty and ppp.conf

Timothy Luoma lists at tntluoma.com
Sun Jan 16 16:02:37 PST 2005 

Dialin modem has been working very well, with the exception of a couple 
times last night when I couldn't connect.  Here's the mgetty logs.  
Note these lines:

01/16 02:10:35 yd0  waiting for ``CONNECT'' ** found **
01/16 02:10:56 yd0  send:
01/16 02:10:56 yd0  waiting for ``_'' ** found **
01/16 02:11:00 yd0  clean_line: only 500 of 10000 bytes logged
01/16 02:11:00 yd0  clean_line: got too much junk (dev=ttyd0).: No such 
file or directory
01/16 02:11:01 ##### failed dev=ttyd0, pid=7942, got signal 3, exiting

[the complete mgetty log is at the end]

There are also some PPP errors:

Jan 16 02:33:23 freebsd ppp[8044]: tun0: Command: default: add default 
HISADDR
Jan 16 02:33:23 freebsd ppp[8044]: tun0: Warning: Add route failed: 
0.0.0.0/0 already exists
Jan 16 02:33:23 freebsd ppp[8044]: tun0: Command: pap: enable pap
Jan 16 02:33:23 freebsd ppp[8044]: tun0: Command: pap: set ifaddr 
192.168.1.3 192.168.1.4-192.168.1.9

here is my ppp.conf... do I need to change the 'set ifaddr' line?

default:
   set device /dev/cuaa0
   set log Phase Chat LCP IPCP CCP tun command
   enable passwdauth
   set speed 115200
   set dial "ABORT BUSY ABORT NO\\sCARRIER TIMEOUT 5 \"\" AT OK-AT-OK 
ATE1Q0 OK \\dATDT\\TTIMEOUT 40 CONNECT"
   set timeout 120
   set ifaddr 192.168.1.1/0 192.168.1.2/0 255.255.255.0 0.0.0.0
   add default HISADDR

cuaa0:
   set ifaddr 192.168.1.3 192.168.1.4-192.168.1.9
   enable passwdauth
   allow users ppp
   accept dns
   set dns 67.36.13.26 66.73.20.40
   enable proxy

pap:
   enable pap
   set ifaddr 192.168.1.3 192.168.1.4-192.168.1.9
   enable proxy
   enable passwdauth

here's another ppp.log snippet that seems to indicate a problem with 
passwdauth, as pppd shouldn't look for etc/ppp/ppp.secret unless 
passwdauth is NOT set:

Jan 16 02:33:26 freebsd ppp[8044]: tun0: Phase: bundle: Authenticate
Jan 16 02:33:26 freebsd ppp[8044]: tun0: Phase: deflink: his = none, 
mine = PAP
Jan 16 02:33:26 freebsd ppp[8044]: tun0: LCP: deflink: 
RecvEchoRequest(0) state = Opened
Jan 16 02:33:26 freebsd ppp[8044]: tun0: LCP: deflink: SendEchoReply(0) 
state = Opened
Jan 16 02:33:26 freebsd ppp[8044]: tun0: Phase: Pap Input: REQUEST (ppp)
Jan 16 02:33:26 freebsd ppp[8044]: tun0: Warning: OpenSecret: Can't 
open /etc/ppp/ppp.secret.
Jan 16 02:33:26 freebsd ppp[8044]: tun0: Phase: Pap Output: SUCCESS
Jan 16 02:33:26 freebsd ppp[8044]: tun0: Warning: OpenSecret: Can't 
open /etc/ppp/ppp.secret.
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP: FSM: Using "deflink" as a 
transport
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP: deflink: State change 
Initial --> Closed
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP: deflink: LayerStart.
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP: MPPE: Not usable without 
CHAP81
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP: deflink: SendConfigReq(1) 
state = Closed
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP:  DEFLATE[4] win 15
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP:  PRED1[2]
Jan 16 02:33:26 freebsd ppp[8044]: tun0: CCP: deflink: State change 
Closed --> Req-Sent
Jan 16 02:33:26 freebsd ppp[8044]: tun0: Phase: deflink: lcp -> open


later on:

Jan 16 02:34:56 freebsd ppp[8082]: tun0: IPCP: myaddr 192.168.1.3 
hisaddr = 192.168.1.5
Jan 16 02:34:56 freebsd ppp[8082]: tun0: Warning: ff02:5::/32: Change 
route failed: errno: Network is unreachable
Jan 16 02:34:56 freebsd ppp[8082]: tun0: LCP: deflink: 
RecvProtocolRej(223) state = Opened
Jan 16 02:34:56 freebsd ppp[8082]: tun0: LCP: deflink: -- Protocol 
0x8057 (Internet Protocol V6 Control Protocol) was rejected!
Jan 16 02:34:56 freebsd ppp[8082]: tun0: Phase: deflink: IPV6CP 
protocol reject closes IPV6CP !
Jan 16 02:34:56 freebsd ppp[8082]: tun0: IPCP: deflink: 
RecvConfigReq(4) state = Opened
Jan 16 02:34:56 freebsd ppp[8082]: tun0: IPCP: deflink: LayerDown: 
192.168.1.3
Jan 16 02:34:56 freebsd ppp[8082]: tun0: IPCP:  COMPPROTO[6] 16 VJ 
slots with slot compression
Jan 16 02:34:56 freebsd ppp[8082]: tun0: IPCP:  IPADDR[6] 192.168.1.5

I don't want to flood the list with log snippets, so I'll stop, but 
will send more if someone thinks it would be beneficial.

Again, the symptoms here are either not getting connected at all on 
dial in, or getting connected but not being able to get anywhere (even 
by IP address).

[here's the complete mgetty log]

01/16 01:51:49 yd0  mgetty: experimental test release 1.1.31-Jul24
01/16 01:51:49 yd0  check for lockfiles
01/16 01:51:49 yd0  locking the line
01/16 01:51:49 yd0  lowering DTR to reset Modem
01/16 01:51:50 yd0  send: \dATQ0V1H0[0d]
01/16 01:51:50 yd0  waiting for ``OK'' ** found **
01/16 01:51:51 yd0  send: ATS0=0Q0&D3&C1[0d]
01/16 01:51:51 yd0  waiting for ``OK'' ** found **
01/16 01:51:51 yd0  mdm_send: 'ATI'
01/16 01:51:51 yd0  Generic Rockwell modem (56000)
01/16 01:51:51 yd0  mdm_send: 'ATI3'
01/16 01:51:51 yd0  mdm_send: 'ATI4'
01/16 01:51:51 yd0  additional info: 'a007040284C6002F'
01/16 01:51:51 yd0  modem quirks: 0004
01/16 01:51:51 yd0  mdm_send: 'AT+FCLASS=2' -> OK
01/16 01:51:51 yd0  mdm_send: 'AT+FCLASS=0' -> OK
01/16 01:51:51 yd0  mdm_send: 'AT+FAA=1;+FCR=1' -> OK
01/16 01:51:51 yd0  mdm_send: 'AT+FBOR=0' -> OK
01/16 01:51:51 yd0  mdm_send: 'AT+FLID="49 115 xxxxxxxx"' -> OK
01/16 01:51:51 yd0  mdm_send: 'AT+FDCC=1,5,0,2,0,0,0,0' -> OK
01/16 01:51:51 yd0  waiting...
01/16 02:10:35 yd0  wfr: waiting for ``RING''
01/16 02:10:35 yd0  send: ATA[0d]
01/16 02:10:35 yd0  waiting for ``CONNECT'' ** found **
01/16 02:10:56 yd0  send:
01/16 02:10:56 yd0  waiting for ``_'' ** found **
01/16 02:11:00 yd0  clean_line: only 500 of 10000 bytes logged
01/16 02:11:00 yd0  clean_line: got too much junk (dev=ttyd0).: No such 
file or directory
01/16 02:11:01 ##### failed dev=ttyd0, pid=7942, got signal 3, exiting

More information about the freebsd-questions mailing list