PPPoE problems with latest -CURRENT
Maxim Maximov
mcsi at mcsi.pp.ru
Sun Aug 1 03:20:09 PDT 2004
Gleb Smirnoff wrote:
> On Sun, Aug 01, 2004 at 01:45:13PM +0400, Maxim Maximov wrote:
> M> My ppp.conf haven't been changed from the time this machine have
> M> FreeBSD installed. Password configured is the same that I'm successfuly
> M> using now with rp-pppoe.
>
> If you suspect ng_pppoe, than please backout ng_pppoe.c to rev 1.65,
> ng_pppoe.h to 1.19. Install backed out ng_pppoe.h, rebuild and reinstall
> both ppp(8) and ng_pppoe(4). Try this and reply whether it works or not.
>
Well, it definitely works. Notice "Warning: deflink: Reducing
configured MRU from 1500 to 1492" which didnt show up in previous logs.
Also I had to backout ppp/ether.c to r1.27
Aug 1 14:14:18 ultra ppp[221]: tun0: Phase: bundle: Establish
Aug 1 14:14:18 ultra ppp[221]: tun0: Phase: deflink: closed -> opening
Aug 1 14:14:18 ultra ppp[221]: tun0: Phase: deflink: Connected!
Aug 1 14:14:18 ultra ppp[221]: tun0: Phase: deflink: opening -> dial
Aug 1 14:14:18 ultra ppp[221]: tun0: Chat: deflink: Dial attempt 1 of 1
Aug 1 14:14:18 ultra ppp[221]: tun0: Phase: deflink: dial -> carrier
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: Received NGM_PPPOE_ACNAME
(hook "MGTS")
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: Received NGM_PPPOE_SESSIONID
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: Received NGM_PPPOE_SUCCESS
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: deflink: carrier -> login
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: deflink: login -> lcp
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: FSM: Using "deflink" as a
transport
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: State change Initial
--> Closed
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: State change Closed
--> Stopped
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: RecvConfigReq(1)
state = Stopped
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MRU[4] 1492
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05)
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MAGICNUM[6] 0x596121ce
Aug 1 14:14:19 ultra ppp[221]: tun0: Warning: deflink: Reducing
configured MRU from 1500 to 1492
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: SendConfigReq(1)
state = Stopped
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: ACFCOMP[2]
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: PROTOCOMP[2]
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: ACCMAP[6] 0x00000000
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MRU[4] 1492
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MAGICNUM[6] 0xc09c974e
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: SendConfigAck(1)
state = Stopped
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MRU[4] 1492
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: AUTHPROTO[5] 0xc223 (CHAP 0x05)
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MAGICNUM[6] 0x596121ce
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: LayerStart
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: State change Stopped
--> Ack-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: RecvConfigAck(1)
state = Ack-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: ACFCOMP[2]
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: PROTOCOMP[2]
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: ACCMAP[6] 0x00000000
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MRU[4] 1492
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MAGICNUM[6] 0xc09c974e
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: State change
Ack-Sent --> Opened
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: LayerUp
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: SendIdent(0) state =
Opened
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MAGICNUM c09c974e
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: TEXT user-ppp 3.2 (built Aug
1 2004)
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: bundle: Authenticate
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: deflink: his = CHAP 0x05,
mine = none
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: Chap Input: CHALLENGE (16
bytes from A947-agr01)
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: Chap Output: RESPONSE
(xxxxxxxxxx)
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: Chap Input: SUCCESS
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: Using trigger address 0.0.0.0
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: FSM: Using "deflink" as a
transport
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: deflink: State change Initial
--> Closed
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: deflink: LayerStart.
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: MPPE: Not usable without CHAP81
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: deflink: SendConfigReq(1)
state = Closed
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: DEFLATE[4] win 15
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: PRED1[2]
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: deflink: State change Closed
--> Req-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: deflink: lcp -> open
Aug 1 14:14:19 ultra ppp[221]: tun0: Phase: bundle: Network
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: FSM: Using "deflink" as a
transport
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: State change
Initial --> Closed
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: LayerStart.
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: SendConfigReq(1)
state = Closed
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: IPADDR[6] 0.0.0.0
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: COMPPROTO[6] 16 VJ slots
with slot compression
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: PRIDNS[6] 212.188.4.10
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: SECDNS[6] 255.255.255.255
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: State change Closed
--> Req-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: RecvConfigReq(1)
state = Req-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: IPADDR[6] 10.2.255.2
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: SendConfigAck(1)
state = Req-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: IPADDR[6] 10.2.255.2
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: State change
Req-Sent --> Ack-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: RecvProtocolRej(2)
state = Opened
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: -- Protocol 0x80fd
(Compression Control Protocol) was rejected!
Aug 1 14:14:19 ultra ppp[221]: tun0: CCP: deflink: State change
Req-Sent --> Stopped
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: RecvConfigRej(1)
state = Ack-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: deflink: SendIdent(1) state =
Opened
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: MAGICNUM c09c974e
Aug 1 14:14:19 ultra ppp[221]: tun0: LCP: TEXT user-ppp 3.2 (built Aug
1 2004)
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: COMPPROTO[6] 16 VJ slots
with slot compression
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: deflink: SendConfigReq(2)
state = Ack-Sent
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: IPADDR[6] 0.0.0.0
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: PRIDNS[6] 212.188.4.10
Aug 1 14:14:19 ultra ppp[221]: tun0: IPCP: SECDNS[6] 255.255.255.255
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: deflink: RecvConfigNak(2)
state = Ack-Sent
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: IPADDR[6] 81.195.16.111
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: IPADDR[6] changing address:
0.0.0.0 --> 81.195.16.111
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: PRIDNS[6] 195.34.32.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: SECDNS[6] 212.188.4.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: Primary nameserver set to
195.34.32.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: Secondary nameserver set to
212.188.4.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: deflink: SendConfigReq(3)
state = Ack-Sent
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: IPADDR[6] 81.195.16.111
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: PRIDNS[6] 195.34.32.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: SECDNS[6] 212.188.4.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: deflink: RecvConfigAck(3)
state = Ack-Sent
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: IPADDR[6] 81.195.16.111
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: PRIDNS[6] 195.34.32.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: SECDNS[6] 212.188.4.10
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: deflink: State change
Ack-Sent --> Opened
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: deflink: LayerUp.
Aug 1 14:14:20 ultra ppp[221]: tun0: IPCP: myaddr 81.195.16.111 hisaddr
= 10.2.255.2
Aug 1 14:14:20 ultra ppp[221]: tun0: LCP: deflink: RecvEchoRequest(1)
state = Opened
Aug 1 14:14:20 ultra ppp[221]: tun0: LCP: deflink: SendEchoReply(1)
state = Opened
Aug 1 14:14:42 ultra ppp[221]: tun0: LCP: deflink: RecvEchoRequest(2)
state = Opened
Aug 1 14:14:42 ultra ppp[221]: tun0: LCP: deflink: SendEchoReply(2)
state = Opened
Aug 1 14:14:52 ultra ppp[221]: tun0: LCP: deflink: RecvEchoRequest(3)
state = Opened
--
Maxim Maximov
More information about the freebsd-current
mailing list