Date: Mon, 07 Feb 2000 23:43:21 +0100 From: 320096206837-0001@t-online.de (Dermot McNally) To: Brian Somers <brian@awfulhak.org> Cc: freebsd-net@FreeBSD.ORG, Brian Somers <brian@awfulhak.org>, Julian Elischer <julian@whistle.com> Subject: Re: PPPoE connection almost working Message-ID: <4.2.0.58.20000207232329.00b06178@tim> In-Reply-To: <200002060053.AAA37872@hak.lan.Awfulhak.org> References: <Message from Dermot McNally <dermot@mcnally.de> <4.2.0.58.20000205001643.00afb778@tim>
next in thread | previous in thread | raw e-mail | index | archive | help
At 00:53 06.02.2000 +0000, Brian Somers wrote: >So as you can see, the local side *should* be sending a PADR. > >[.....] > > Feb 5 00:21:59 tim ppp[581]: tun0: Warning: deflink: Reducing MTU to 1492 > > Feb 5 00:21:59 tim ppp[581]: tun0: Phase: deflink: Connected! > > Feb 5 00:21:59 tim ppp[581]: tun0: Phase: deflink: opening -> dial > > Feb 5 00:21:59 tim ppp[581]: tun0: Phase: deflink: dial -> carrier > > Feb 5 00:22:04 tim ppp[581]: tun0: Phase: deflink: Disconnected! > > Feb 5 00:22:04 tim ppp[581]: tun0: Phase: deflink: carrier -> hangup >[.....] > >I don't really know why the PPPoE node isn't responding to the PADO. >it looks good from here. I can now report success. I updated to current and it Just Worked. I must admit to being very pleasantly surprised - I expected at least one nasty hurdle, and was preparing to dissect the output of tcpdump when I realised there was a lot more of it than there had been before. I looked at ppp and noticed that the link was alive. You can't complain, can you? Anyway, well done to Julian and Brian for the code that does all this. You've done a phenomenal job. The link comes up in a fraction of a second (which is important, since Deutsche Telekom doesn't offer an always-on connection at decent rates) and I've done a test download at 87 K-bytes/s, pretty much on the edge of the claimed bandwidth of my pipe. One further question - with reference to the ppp log below, is it normal that I should have all those LCP entries? They keep repeating as long as the link is up. I can just stop logging them, of course, but is there something else I should tweak instead? Thanks again, Dermot Feb 7 23:04:20 tim ppp[312]: tun0: Command: /dev/tty: dial dsl Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set device PPPoE:ed0 Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set mru 1490 Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set mtu 1490 Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: deny chap Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: accept pap Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set speed sync Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set cd 5 Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: enable lqr Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set redial 0 0 Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set dial Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: add 0 0 HISADDR Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set login Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set authname xxxxxxxxxxxxxxxxxx@t-online.de Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set authkey ******** Feb 7 23:04:20 tim ppp[312]: tun0: Command: dsl: set timeout 120 Feb 7 23:04:20 tim ppp[312]: tun0: Phase: bundle: Establish Feb 7 23:04:20 tim ppp[312]: tun0: Phase: deflink: closed -> opening Feb 7 23:04:20 tim ppp[312]: tun0: Phase: deflink: Connected! Feb 7 23:04:20 tim ppp[312]: tun0: Phase: deflink: opening -> dial Feb 7 23:04:20 tim ppp[312]: tun0: Phase: deflink: dial -> carrier Feb 7 23:04:21 tim ppp[312]: tun0: Phase: Received NGM_PPPOE_SUCCESS (hook "tun0") Feb 7 23:04:21 tim ppp[312]: tun0: Phase: deflink: carrier -> login Feb 7 23:04:21 tim ppp[312]: tun0: Phase: deflink: login -> lcp Feb 7 23:04:21 tim ppp[312]: tun0: LCP: FSM: Using "deflink" as a transport Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: State change Initial --> Closed Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: State change Closed --> Stopped Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: RecvConfigReq(231) state = Stopped Feb 7 23:04:21 tim ppp[312]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 7 23:04:21 tim ppp[312]: tun0: LCP: MAGICNUM[6] 0x076d5d32 Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: SendConfigReq(1) state = Stopped Feb 7 23:04:21 tim ppp[312]: tun0: LCP: MRU[4] 1490 Feb 7 23:04:21 tim ppp[312]: tun0: LCP: MAGICNUM[6] 0x346e9523 Feb 7 23:04:21 tim ppp[312]: tun0: LCP: QUALPROTO[8] proto c025, interval 30000ms Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: SendConfigAck(231) state = Stopped Feb 7 23:04:21 tim ppp[312]: tun0: LCP: AUTHPROTO[4] 0xc023 (PAP) Feb 7 23:04:21 tim ppp[312]: tun0: LCP: MAGICNUM[6] 0x076d5d32 Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: LayerStart Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: State change Stopped --> Ack-Sent Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: RecvConfigNak(1) state = Ack-Sent Feb 7 23:04:21 tim ppp[312]: tun0: LCP: MRU[4] 1500 Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: SendConfigReq(2) state = Ack-Sent Feb 7 23:04:21 tim ppp[312]: tun0: LCP: MRU[4] 1500 Feb 7 23:04:21 tim ppp[312]: tun0: LCP: MAGICNUM[6] 0x346e9523 Feb 7 23:04:21 tim ppp[312]: tun0: LCP: QUALPROTO[8] proto c025, interval 30000ms Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: RecvConfigAck(2) state = Ack-Sent Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: State change Ack-Sent --> Opened Feb 7 23:04:21 tim ppp[312]: tun0: LCP: deflink: LayerUp Feb 7 23:04:21 tim ppp[312]: tun0: Phase: bundle: Authenticate Feb 7 23:04:21 tim ppp[312]: tun0: Phase: deflink: his = PAP, mine = none Feb 7 23:04:21 tim ppp[312]: tun0: Phase: Pap Output: xxxxxxxxxxxxxx@t-online.de ******** Feb 7 23:04:21 tim ppp[312]: tun0: Phase: Pap Input: SUCCESS () Feb 7 23:04:21 tim ppp[312]: tun0: Phase: deflink: lcp -> open Feb 7 23:04:21 tim ppp[312]: tun0: Phase: bundle: Network Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: FSM: Using "deflink" as a transport Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: State change Initial --> Closed Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: LayerStart. Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: SendConfigReq(1) state = Closed Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: IPADDR[6] 192.168.0.254 Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: State change Closed --> Req-Sent Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: RecvConfigReq(244) state = Req-Sent Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: IPADDR[6] 193.158.139.181 Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: SendConfigAck(244) state = Req-Sent Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: IPADDR[6] 193.158.139.181 Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: State change Req-Sent --> Ack-Sent Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: RecvConfigNak(1) state = Ack-Sent Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: IPADDR[6] 62.158.208.217 Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: IPADDR[6] changing address: 192.168.0.254 --> 62.158.208.217 Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: deflink: SendConfigReq(2) state = Ack-Sent Feb 7 23:04:21 tim ppp[312]: tun0: IPCP: IPADDR[6] 62.158.208.217 Feb 7 23:04:22 tim ppp[312]: tun0: IPCP: deflink: RecvConfigAck(2) state = Ack-Sent Feb 7 23:04:22 tim ppp[312]: tun0: IPCP: deflink: State change Ack-Sent --> Opened Feb 7 23:04:22 tim ppp[312]: tun0: IPCP: deflink: LayerUp. Feb 7 23:04:22 tim ppp[312]: tun0: IPCP: myaddr 62.158.208.217 hisaddr = 193.158.139.181 Feb 7 23:04:22 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(1) state = Opened Feb 7 23:04:22 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(1) state = Opened Feb 7 23:04:25 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(2) state = Opened Feb 7 23:04:25 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(2) state = Opened Feb 7 23:04:28 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(3) state = Opened Feb 7 23:04:28 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(3) state = Opened Feb 7 23:04:31 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(4) state = Opened Feb 7 23:04:31 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(4) state = Opened Feb 7 23:04:34 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(5) state = Opened Feb 7 23:04:34 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(5) state = Opened Feb 7 23:04:37 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(6) state = Opened Feb 7 23:04:37 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(6) state = Opened Feb 7 23:04:40 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(7) state = Opened Feb 7 23:04:40 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(7) state = Opened Feb 7 23:04:43 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(8) state = Opened Feb 7 23:04:43 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(8) state = Opened Feb 7 23:04:46 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(9) state = Opened Feb 7 23:04:46 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(9) state = Opened Feb 7 23:04:49 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(10) state = Opened Feb 7 23:04:49 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(10) state = Opened Feb 7 23:04:52 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(11) state = Opened Feb 7 23:04:52 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(11) state = Opened Feb 7 23:04:55 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(12) state = Opened Feb 7 23:04:55 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(12) state = Opened Feb 7 23:04:58 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(13) state = Opened Feb 7 23:04:58 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(13) state = Opened Feb 7 23:05:01 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(14) state = Opened Feb 7 23:05:01 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(14) state = Opened Feb 7 23:05:04 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(15) state = Opened Feb 7 23:05:04 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(15) state = Opened Feb 7 23:05:07 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(16) state = Opened Feb 7 23:05:07 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(16) state = Opened Feb 7 23:05:10 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(17) state = Opened Feb 7 23:05:10 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(17) state = Opened Feb 7 23:05:13 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(18) state = Opened Feb 7 23:05:13 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(18) state = Opened Feb 7 23:05:16 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(19) state = Opened Feb 7 23:05:16 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(19) state = Opened Feb 7 23:05:19 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(20) state = Opened Feb 7 23:05:19 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(20) state = Opened Feb 7 23:05:22 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(21) state = Opened Feb 7 23:05:22 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(21) state = Opened Feb 7 23:05:25 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(22) state = Opened Feb 7 23:05:25 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(22) state = Opened Feb 7 23:05:28 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(23) state = Opened Feb 7 23:05:28 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(23) state = Opened Feb 7 23:05:31 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(24) state = Opened Feb 7 23:05:31 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(24) state = Opened Feb 7 23:05:34 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(25) state = Opened Feb 7 23:05:34 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(25) state = Opened Feb 7 23:05:37 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(26) state = Opened Feb 7 23:05:37 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(26) state = Opened Feb 7 23:05:40 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(27) state = Opened Feb 7 23:05:40 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(27) state = Opened Feb 7 23:05:43 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(28) state = Opened Feb 7 23:05:43 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(28) state = Opened Feb 7 23:05:46 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(29) state = Opened Feb 7 23:05:46 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(29) state = Opened Feb 7 23:05:49 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(30) state = Opened Feb 7 23:05:49 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(30) state = Opened Feb 7 23:05:52 tim ppp[312]: tun0: LCP: deflink: RecvEchoRequest(31) state = Opened Feb 7 23:05:52 tim ppp[312]: tun0: LCP: deflink: SendEchoReply(31) state = Opened Feb 7 23:05:54 tim ppp[312]: tun0: Command: /dev/tty: close Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: deflink: LayerDown: 62.158.208.217 Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: deflink: SendTerminateReq(3) state = Opened Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: deflink: State change Opened --> Closing Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: deflink: RecvTerminateAck(3) state = Closing Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: deflink: LayerFinish. Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: Connect time: 93 secs: 8505 octets in, 4845 octets out Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: total 143 bytes/sec, peak 1167 bytes/sec on Mon Feb 7 23:05:54 2000 Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: deflink: State change Closing --> Closed Feb 7 23:05:54 tim ppp[312]: tun0: Phase: bundle: Terminate Feb 7 23:05:54 tim ppp[312]: tun0: LCP: deflink: LayerDown Feb 7 23:05:54 tim ppp[312]: tun0: LCP: deflink: SendTerminateReq(3) state = Opened Feb 7 23:05:54 tim ppp[312]: tun0: LCP: deflink: State change Opened --> Closing Feb 7 23:05:54 tim ppp[312]: tun0: Phase: deflink: open -> lcp Feb 7 23:05:54 tim ppp[312]: tun0: IPCP: deflink: State change Closed --> Initial Feb 7 23:05:54 tim ppp[312]: tun0: LCP: deflink: RecvTerminateAck(3) state = Closing Feb 7 23:05:54 tim ppp[312]: tun0: LCP: deflink: LayerFinish Feb 7 23:05:54 tim ppp[312]: tun0: LCP: deflink: State change Closing --> Closed Feb 7 23:05:54 tim ppp[312]: tun0: LCP: deflink: State change Closed --> Initial Feb 7 23:05:54 tim ppp[312]: tun0: Phase: deflink: Disconnected! Feb 7 23:05:54 tim ppp[312]: tun0: Phase: deflink: lcp -> logout Feb 7 23:05:54 tim ppp[312]: tun0: Phase: deflink: logout -> hangup Feb 7 23:05:54 tim ppp[312]: tun0: Phase: deflink: Disconnected! Feb 7 23:05:54 tim ppp[312]: tun0: Phase: deflink: Connect time: 94 secs: 9360 octets in, 5771 octets out Feb 7 23:05:54 tim ppp[312]: tun0: Phase: total 160 bytes/sec, peak 1207 bytes/sec on Mon Feb 7 23:05:54 2000 Feb 7 23:05:54 tim ppp[312]: tun0: Phase: deflink: hangup -> closed Feb 7 23:05:54 tim ppp[312]: tun0: Phase: bundle: Dead To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-net" in the body of the message
Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?4.2.0.58.20000207232329.00b06178>