>Number:         19303
>Category:       kern
>Synopsis:       "ifconfig pppoe0 up" works only once per boot
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    kern-bug-people
>State:          open
>Class:          sw-bug
>Submitter-Id:   net
>Arrival-Date:   Fri Dec 06 10:45:01 PST 2002
>Closed-Date:
>Last-Modified:
>Originator:     Amitai Schlair
>Release:        NetBSD 1.6F
>Organization:
Schmonz Enterprises, Inc.
>Environment:
NetBSD home.schmonz.com 1.6F NetBSD 1.6F (AMBRA) #0: Sun Aug 18 12:39:54 EDT 2002     schmonz@juice:/raid1/home/schmonz/netbsd/src/sys/arch/i386/compile/AMBRA i386
>Description:
My pppoe connection, which uses PAP and provides a static IP,
usually looks like this:

pppoe0: flags=8851<UP,POINTOPOINT,RUNNING,SIMPLEX,MULTICAST> mtu 1492
        inet 206.183.9.221 -> 0.0.0.1 netmask 0xff000000
        inet6 fe80::2a0:24ff:fe5c:75f2%pppoe0 -> :: prefixlen 64 scopeid 0xa

Occasionally, it goes down, printing the following message to the console:

pppoe0: LCP keepalive timed out, going to restart the connection

When this message occurs, I'd expect the connection to be reestablished
shortly. However, this never happens. Rebooting the machine always
restores the connection.

In a previous discussion with Martin, he noted that at least two
wrong things occur during IP negotiation: we suggest that the remote
peer be 0.0.0.1, and it agrees!

$ ifconfig pppoe0
pppoe0: flags=8810<POINTOPOINT,SIMPLEX,MULTICAST> mtu 1492
        inet 0.0.0.0 -> 0.0.0.0 netmask 0xff000000
        inet6 fe80::2a0:24ff:fe5c:75f2%pppoe0 -> :: prefixlen 64 scopeid 0xa

$ date
Fri Aug  9 00:10:31 EDT 2002

$ sudo pppoectl -d pppoe0
pppoe0: state = initial
        Session ID: 0x0
        PADI retries: 3
        PADR retries: 0

$ date
Fri Aug  9 00:12:31 EDT 2002

$ sudo pppoectl -d pppoe0
pppoe0: state = initial
        Session ID: 0x0
        PADI retries: 3
        PADR retries: 0

Messages from "ifconfig pppoe0 down; ifconfig pppoe0 debug; ifconfig pppoe0 up":

Aug  9 00:13:22 home /netbsd: pppoe0: lcp close(initial)
Aug  9 00:13:22 home /netbsd: pppoe0: lcp open(initial)
Aug  9 00:13:22 home /netbsd: pppoe0: phase establish
Aug  9 00:13:22 home /netbsd: pppoe0: session 0xdf8 connected
Aug  9 00:13:22 home /netbsd: pppoe0: lcp up(starting)
Aug  9 00:13:22 home /netbsd: pppoe0: lcp output <conf-req id=0x26 len=10 05-06-42-7c-3c-55>
Aug  9 00:13:22 home /netbsd: pppoe0: lcp input(req-sent): <conf-req id=0xc len=18 01-04-05-d4-03-04-c0-23-05-06-25-fe-b2-d0-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00>
Aug  9 00:13:22 home /netbsd: pppoe0: lcp parse opts: mru auth-proto magic
Aug  9 00:13:22 home /netbsd: pppoe0: lcp parse opt values:  mru 1492 auth-proto magic 0x25feb2d0 send conf-ack
Aug  9 00:13:22 home /netbsd: pppoe0: lcp output <conf-ack id=0xc len=18 01-04-05-d4-03-04-c0-23-05-06-25-fe-b2-d0>
Aug  9 00:13:22 home /netbsd: pppoe0: lcp input(ack-sent): <conf-ack id=0x26 len=10 05-06-42-7c-3c-55-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00>
Aug  9 00:13:22 home /netbsd: pppoe0: lcp tlu
Aug  9 00:13:22 home /netbsd: pppoe0: phase authenticate
Aug  9 00:13:22 home /netbsd: pppoe0: pap output <req id=0x7 len=28 10-61-73-69-32-37-38-39-39-40-61-70-6b-2e-6e-65-74-06-43-24-75-32-37-6b>
Aug  9 00:13:22 home /netbsd: pppoe0: lcp input(opened): <conf-req id=0x1 len=14 03-04-c0-23-05-06-5a-c5-33-62-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00>
Aug  9 00:13:22 home /netbsd: pppoe0: lcp parse opts: auth-proto magic
Aug  9 00:13:23 home /netbsd: pppoe0: lcp parse opt values:  auth-proto magic 0x5ac53362 send conf-ack
Aug  9 00:13:23 home /netbsd: pppoe0: lcp output <conf-ack id=0x1 len=14 03-04-c0-23-05-06-5a-c5-33-62>
Aug  9 00:13:23 home /netbsd: pppoe0: phase terminate
Aug  9 00:13:23 home /netbsd: pppoe0: lcp output <conf-req id=0x27 len=10 05-06-42-7c-3c-55>
Aug  9 00:13:23 home /netbsd: pppoe0: lcp input(ack-sent): <conf-ack id=0x27 len=10 05-06-42-7c-3c-55-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00>
Aug  9 00:13:23 home /netbsd: pppoe0: lcp tlu
Aug  9 00:13:23 home /netbsd: pppoe0: phase authenticate
Aug  9 00:13:23 home /netbsd: pppoe0: pap output <req id=0x8 len=28 10-61-73-69-32-37-38-39-39-40-61-70-6b-2e-6e-65-74-06-43-24-75-32-37-6b>
Aug  9 00:13:23 home /netbsd: pppoe0: pap peer TO
Aug  9 00:13:23 home /netbsd: pppoe0: pap output <req id=0x9 len=28 10-61-73-69-32-37-38-39-39-40-61-70-6b-2e-6e-65-74-06-43-24-75-32-37-6b>
Aug  9 00:13:23 home /netbsd: pppoe0: pap success
Aug  9 00:13:23 home /netbsd: pppoe0: phase network
Aug  9 00:13:23 home /netbsd: pppoe0: ipcp_open(): no IP interface
Aug  9 00:13:23 home /netbsd: pppoe0: ipv6cp open(closed)
Aug  9 00:13:24 home /netbsd: pppoe0: ipv6cp output <conf-req id=0x9 len=14 01-0a-02-a0-24-ff-fe-5c-75-f2>
Aug  9 00:13:24 home /netbsd: pppoe0: lcp close(opened)
Aug  9 00:13:24 home /netbsd: pppoe0: phase terminate
Aug  9 00:13:24 home /netbsd: pppoe0: lcp output <term-req id=0x28 len=4>
Aug  9 00:13:24 home /netbsd: pppoe0: lcp input(closing): <proto-rej id=0x2 len=20 80-57-01-09-00-0e-01-0a-02-a0-24-ff-fe-5c-75-f2-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00>
Aug  9 00:13:24 home /netbsd: pppoe0: lcp: RXJ+ (proto-rej) for proto 0x8057 (ipv6cp/req-sent)
Aug  9 00:13:24 home /netbsd: pppoe0: ipv6cp close(req-sent)
Aug  9 00:13:24 home /netbsd: pppoe0: ipv6cp output <term-req id=0xa len=4>
Aug  9 00:13:24 home /netbsd: pppoe0: lcp input(closing): <term-ack id=0x28 len=4 00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00-00>
Aug  9 00:13:24 home /netbsd: pppoe0: phase dead
Aug  9 00:13:25 home /netbsd: pppoe0: disconnecting
Aug  9 00:13:25 home /netbsd: pppoe0: lcp down(closed)
Aug  9 00:13:25 home /netbsd: pppoe0: Down event (carrier loss), taking interface down.
Aug  9 00:13:25 home /netbsd: pppoe0: ipv6cp TO(closing) rst_counter = 2
Aug  9 00:13:25 home /netbsd: pppoe0: ipv6cp output <term-req id=0xb len=4>
Aug  9 00:13:25 home /netbsd: pppoe0: ipv6cp TO(closing) rst_counter = 1
Aug  9 00:13:25 home /netbsd: pppoe0: ipv6cp output <term-req id=0xc len=4>
Aug  9 00:13:26 home /netbsd: pppoe0: ipv6cp TO(closing) rst_counter = 0

>How-To-Repeat:
Connect to my local ISP's DSL service using NetBSD's pppoe(4). Wait
an arbitrary period of time (usually days to weeks). Discover that
the network connection has fallen, and can't get up.

>Fix:
None provided, sorry.
>Release-Note:
>Audit-Trail:
>Unformatted: