Skip site navigation (1)Skip section navigation (2)
Date:      Fri, 5 Jun 1998 08:12:01 -0300
From:      "Marco Shaw" <marco@nbnet.nb.ca>
To:        <freebsd-questions@FreeBSD.ORG>
Subject:   PPP & ppp.log
Message-ID:  <000701bd9072$c3652860$0a22a10a@ipo10161034010.nbtel.net>

next in thread | raw e-mail | index | archive | help
Here's my PPP log for one dial-up attempt.  The relevant sections, in my
opinion, are delimited by '*'s.  I activate ppp by 1) typing ppp at the
prompt, 2) then starting the dialing by entering 'dial ISP'.  If I
understand correctly, the ppp session has successfully started when I see my
prompt 'ppp..>' change to 'PPP...>'.  Once the prompt changes to uppercase,
I try to ping my nameserver by IP address and get something like:

ping: sendto: Address family not supported by protocol family

netstat -rn gives me:

Detination		Gateway ...
156.34.145.3	156.34.10.145...

Not being highly educated in TCP/IP, I'm trying to ping 198.164.30.2 so it
may seem like my system has no idea that the 198.* family lies outside my
system?  Any ideas on an entry I might be missing in ppp.conf?  I don't
quite understand the entries in my ppp.log below that is found in between
the '*'s.  With debugging fully enabled, does it seem to indicate that my
connection seems to be good.

(TW  I have not modified any other files apart from ppp.log and ppp.linkup
so I must find where the nameservers go later.)

Any help would be appreciated.

Marco


Jun  4 20:09:05 myname ppp[300]: Command: default: set device /dev/cuaa2
Jun  4 20:09:05 myname ppp[300]: Command: default: set speed 57600
Jun  4 20:09:05 myname ppp[300]: Command: default: set dial ABORT BUSY ABORT
NO\sCARRIER TIMEOUT 5 "" AT OK-AT-AK ATE1Q0 OK \dATDT\T TIMEOUT 40 CONNECT
Jun  4 20:09:05 myname ppp[300]: tun0: Phase: Using interface: tun0
Jun  4 20:09:05 myname ppp[300]: tun0: Phase: PPP Started.
Jun  4 20:09:09 myname ppp[300]: tun0: Command: dial ISP
Jun  4 20:09:09 myname ppp[300]: tun0: Command: ISP: set phone 6490201
Jun  4 20:09:09 myname ppp[300]: tun0: Command: ISP: set login TIMEOUT 5
username:-\-r-username: marco2 Password: RMVETVGE
Jun  4 20:09:09 myname ppp[300]: tun0: Command: ISP: set timeout 120
Jun  4 20:09:09 myname ppp[300]: tun0: Command: ISP: set ifaddr
156.34.10.145
Jun  4 20:09:09 myname ppp[300]: tun0: Command: ISP: set openmode passive
Jun  4 20:09:09 myname ppp[300]: tun0: Command: ISP: enable lqr
Jun  4 20:09:09 myname ppp[300]: tun0: Command: ISP: add 0 0 HISADDR
Jun  4 20:09:09 myname ppp[300]: tun0: Phase: Connected!
Jun  4 20:09:09 myname ppp[300]: tun0: Chat: Expecting:
Jun  4 20:09:09 myname ppp[300]: tun0: Chat: Sending: AT^M
Jun  4 20:09:09 myname ppp[300]: tun0: Chat: Expecting: OK-AT-AK
Jun  4 20:09:09 myname ppp[300]: tun0: Chat: Wait for (5): OK
Jun  4 20:09:09 myname ppp[300]: tun0: Connect: AT^M^M
Jun  4 20:09:09 myname ppp[300]: tun0: Connect: OK
Jun  4 20:09:09 myname ppp[300]: tun0: Chat: Sending: ATE1Q0^M
Jun  4 20:09:09 myname ppp[300]: tun0: Chat: Expecting: OK
Jun  4 20:09:09 myname ppp[300]: tun0: Chat: Wait for (5): OK
Jun  4 20:09:09 myname ppp[300]: tun0: Connect: ^M
Jun  4 20:09:09 myname ppp[300]: tun0: Connect: ATE1Q0^M^M
Jun  4 20:09:09 myname ppp[300]: tun0: Connect: OK
Jun  4 20:09:11 myname ppp[300]: tun0: Phase: Phone: 6490201
Jun  4 20:09:11 myname ppp[300]: tun0: Chat: Sending: ATDT6490201^M
Jun  4 20:09:11 myname ppp[300]: tun0: Chat: Expecting: CONNECT
Jun  4 20:09:11 myname ppp[300]: tun0: Chat: Wait for (40): CONNECT
Jun  4 20:09:11 myname ppp[300]: tun0: Connect: ^M
Jun  4 20:09:25 myname ppp[300]: tun0: Connect: ATDT6490201^M^M
Jun  4 20:09:25 myname ppp[300]: tun0: Connect: CONNECT
Jun  4 20:09:25 myname ppp[300]: tun0: Chat: Expecting:
username:-\-r-username:
Jun  4 20:09:25 myname ppp[300]: tun0: Chat: Wait for (5): username:
Jun  4 20:09:25 myname ppp[300]: tun0: Connect:  31200/ARQ/V34/LAPM/V42BIS^M
Jun  4 20:09:27 myname ppp[300]: tun0: Connect: authentication,  ...^M
Jun  4 20:09:27 myname ppp[300]: tun0: Connect: Please wait.....^M
Jun  4 20:09:27 myname ppp[300]: tun0: Connect: ^M
Jun  4 20:09:27 myname ppp[300]: tun0: Connect: ^M
Jun  4 20:09:27 myname ppp[300]: tun0: Connect: username:
Jun  4 20:09:27 myname ppp[300]: tun0: Chat: Sending: marco2^M
Jun  4 20:09:27 myname ppp[300]: tun0: Chat: Expecting: Password:
Jun  4 20:09:27 myname ppp[300]: tun0: Chat: Wait for (5): Password:
Jun  4 20:09:28 myname ppp[300]: tun0: Connect: XXXXXX^M
Jun  4 20:09:28 myname ppp[300]: tun0: Connect: Password:
Jun  4 20:09:28 myname ppp[300]: tun0: Chat: Sending: XXXXXXX^M
****************************************************************************
*********
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: State change Initial --> Closed
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: State change Closed --> Stopped
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: Received Configure Request (1)
state = Stopped (3)
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACCMAP[6] 0x00000000
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  MAGICNUM[6] 0x8c4e3b46
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  PROTOCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACFCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: LcpSendConfigReq
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACFCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  PROTOCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACCMAP[6] 0x00000000
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  MRU[4] 1500
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  MAGICNUM[6] 0x1cafa160
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  QUALPROTO[8] period 3000
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: SendConfigAck(Stopped)
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACCMAP[6] 0x00000000
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  MAGICNUM[6] 0x8c4e3b46
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  PROTOCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACFCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: State change Stopped -->
Ack-Sent
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: Received Configure Reject (1)
state = Ack-Sent (8)
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: RecvConfigRej.
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  QUALPROTO[8] proto c025,
interval 30000ms
Jun  4 20:09:28 myname ppp[300]: tun0: LCP: LcpSendConfigReq
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACFCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  PROTOCOMP[2]
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  ACCMAP[6] 0x00000000
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  MRU[4] 1500
Jun  4 20:09:28 myname ppp[300]: tun0: LCP:  MAGICNUM[6] 0x1cafa160
Jun  4 20:09:29 myname ppp[300]: tun0: LCP: Received Configure Ack (2) state
= Ack-Sent (8)
Jun  4 20:09:29 myname ppp[300]: tun0: LCP: State change Ack-Sent --> Opened
Jun  4 20:09:29 myname ppp[300]: tun0: LCP: LcpLayerUp
Jun  4 20:09:29 myname ppp[300]: tun0: Phase: NewPhase: Authenticate
Jun  4 20:09:29 myname ppp[300]: tun0: Phase: NewPhase: Network
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: State change Initial --> Closed
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: IPCP Up event!!
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: IpcpSendConfigReq
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP:  IPADDR[6] 156.34.10.145
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP:  COMPPROTO[6] 16 VJ slots with
slot compres
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: State change Closed -->
Req-Sent
Jun  4 20:09:29 myname ppp[300]: tun0: CCP: State change Initial --> Closed
Jun  4 20:09:29 myname ppp[300]: tun0: CCP: CCP Up event!!
Jun  4 20:09:29 myname ppp[300]: tun0: CCP: CcpSendConfigReq
Jun  4 20:09:29 myname ppp[300]: tun0: CCP:  DEFLATE[4] win 15
Jun  4 20:09:29 myname ppp[300]: tun0: CCP:  PRED1[2]
Jun  4 20:09:29 myname ppp[300]: tun0: CCP: State change Closed --> Req-Sent
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: Received Configure Request (1)
state = Req-Sent (6)
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP:  COMPPROTO[6]  16 VJ slots
without slot compression
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP:  IPADDR[6]  156.34.145.3
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: SendConfigAck(Req-Sent)
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP:  COMPPROTO[6]  16 VJ slots
without slot compression
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP:  IPADDR[6]  156.34.145.3
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: State change Req-Sent -->
Ack-Sent
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: Received Configure Ack (1)
state = Ack-Sent (8)
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: State change Ack-Sent -->
Opened
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP: IpcpLayerUp(9).
Jun  4 20:09:29 myname ppp[300]: tun0: IPCP:  myaddr = 156.34.10.145
hisaddr = 156.34.145.3
Jun  4 20:09:29 myname ppp[300]: tun0: LCP: OsLinkup: 156.34.145.3
Jun  4 20:09:29 myname ppp[300]: tun0: Command: MYADDR: add 0 0 HISADDR
Jun  4 20:09:29 myname ppp[300]: tun0: LCP: Received Protocol Reject (2)
state = Opened (9)
Jun  4 20:09:29 myname ppp[300]: tun0: LCP: -- Protocol (80fd) was rejected.
Jun  4 20:09:29 myname ppp[300]: tun0: CCP: CcpLayerFinish.
Jun  4 20:09:29 myname ppp[300]: tun0: CCP: State change Req-Sent -->
Stopped
Jun  4 20:09:29 myname ppp[300]: tun0: LCP: Received Echo Reply (3) state =
Opened (9)
Jun  4 20:09:59 myname ppp[300]: tun0: LCP: Received Echo Reply (4) state =
Opened (9)
Jun  4 20:10:19 myname ppp[300]: tun0: Command: close
Jun  4 20:10:19 myname ppp[300]: tun0: Phase: NewPhase: Terminate
Jun  4 20:10:19 myname ppp[300]: tun0: IPCP: OsLinkdown: 156.34.145.3
Jun  4 20:10:19 myname ppp[300]: tun0: IPCP: IpcpLayerDown.
Jun  4 20:10:19 myname ppp[300]: tun0: IPCP: Connect time: 50 secs: 0 octets
in, 0 octets out
Jun  4 20:10:19 myname ppp[300]: tun0: IPCP:  total 0 bytes/sec
Jun  4 20:10:19 myname ppp[300]: tun0: IPCP: State change Opened -->
Starting
Jun  4 20:10:19 myname ppp[300]: tun0: CCP: CcpLayerStart.
Jun  4 20:10:19 myname ppp[300]: tun0: CCP: State change Stopped -->
Starting
Jun  4 20:10:19 myname ppp[300]: tun0: LCP: LcpLayerDown
Jun  4 20:10:19 myname ppp[300]: tun0: LCP: SendTerminateReq.
Jun  4 20:10:19 myname ppp[300]: tun0: LCP: State change Opened --> Closing
Jun  4 20:10:19 myname ppp[300]: tun0: LCP: Received Terminate Ack (3) state
= Closing (4)
Jun  4 20:10:19 myname ppp[300]: tun0: LCP: State change Closing --> Closed
Jun  4 20:10:19 myname ppp[300]: tun0: LCP: LcpLayerFinish
Jun  4 20:10:20 myname ppp[300]: tun0: Phase: Modem: Connect time: 71 secs:
389 octets in, 311 octets out
Jun  4 20:10:20 myname ppp[300]: tun0: Phase:  total 9 bytes/sec
Jun  4 20:10:20 myname ppp[300]: tun0: Phase: NewPhase: Dead
Jun  4 20:10:21 myname ppp[300]: tun0: Command: q
Jun  4 20:10:22 myname ppp[300]: tun0: Phase: PPP Terminated (normal).
****************************************************************************
**


To Unsubscribe: send mail to majordomo@FreeBSD.org
with "unsubscribe freebsd-questions" in the body of the message



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?000701bd9072$c3652860$0a22a10a>