Subject: Help! rp-pppoe and PacBell DSL
To: None <port-i386@netbsd.org>
From: None <Catidae@aol.com>
List: port-i386
Date: 09/14/2002 22:07:05
Greetings,

I use PacBell's DSL service; it works great with the Windows software they sent me, but I would love to run it using a NetBSD gateway instead.

The gateway has two NICs, and I know they both work (I can connect both to my LAN). One has an IP address, the other (connected to the DSL modem) is not configured. I tried to follow the Roaring Penguin instructions but was unable to connect, I've pasted the debug log at the end of this message.

Does anyone have an idea as to why I can't connect? Do I need to enable DHCP on the unconfigured NIC? Does the kernel not support PPPoE? Does PacBell require that pppoe be configured a certain way? Any help will be much appreciated!

Here's the log:

---------------------------------------------
* The following section contains information about your system
Sat Sep 14 17:33:45 PDT 2002
Output of uname -a
NetBSD pato.home.net 1.5.2 NetBSD 1.5.2 (GENERIC) #3: Sat Aug 18 23:37:05 CEST 2001     he@hamster.urc.uninett.no:/usr/src/sys/arch/i386/compile/GENERIC i386
---------------------------------------------
* The following section contains information about your network
* interfaces.  The one you chose for PPPoE should contain the words:
* 'UP' and 'RUNNING'.  If it does not, you probably have an Ethernet
* driver problem.
Output of ifconfig -a
ex0: flags=8863<UP,BROADCAST,NOTRAILERS,RUNNING,SIMPLEX,MULTICAST> mtu 1500
    address: 00:50:04:61:10:da
    media: Ethernet 10baseT
    status: active
    inet6 fe80::250:4ff:fe61:10da%ex0 prefixlen 64 scopeid 0x1
rtk0: flags=8843<UP,BROADCAST,RUNNING,SIMPLEX,MULTICAST> mtu 1500
    address: 00:30:1b:0b:1e:23
    media: Ethernet autoselect (100baseTX full-duplex)
    status: active
    inet 10.0.0.3 netmask 0xffffff00 broadcast 10.0.0.255
    inet6 fe80::230:1bff:fe0b:1e23%rtk0 prefixlen 64 scopeid 0x2
lo0: flags=8009<UP,LOOPBACK,MULTICAST> mtu 33228
    inet 127.0.0.1 netmask 0xff000000
    inet6 fe80::1%lo0 prefixlen 64 scopeid 0x3
    inet6 ::1 prefixlen 128
ppp0: flags=8010<POINTOPOINT,MULTICAST> mtu 1500
ppp1: flags=8010<POINTOPOINT,MULTICAST> mtu 1500
sl0: flags=c010<POINTOPOINT,LINK2,MULTICAST> mtu 296
sl1: flags=c010<POINTOPOINT,LINK2,MULTICAST> mtu 296
strip0: flags=0<> mtu 1100
strip1: flags=0<> mtu 1100
tun0: flags=10<POINTOPOINT> mtu 1500
tun1: flags=10<POINTOPOINT> mtu 1500
gre0: flags=8010<POINTOPOINT,MULTICAST> mtu 1450
gre1: flags=8010<POINTOPOINT,MULTICAST> mtu 1450
ipip0: flags=8010<POINTOPOINT,MULTICAST>
ipip1: flags=8010<POINTOPOINT,MULTICAST>
gif0: flags=8010<POINTOPOINT,MULTICAST> mtu 1280
gif1: flags=8010<POINTOPOINT,MULTICAST> mtu 1280
gif2: flags=8010<POINTOPOINT,MULTICAST> mtu 1280
gif3: flags=8010<POINTOPOINT,MULTICAST> mtu 1280
---------------------------------------------
* The following section lists your routing table.
* If you have an entry which starts with '0.0.0.0', you probably
* have defined a default route and gateway, and pppd will
* not create a default route using your ISP.  Try getting
* rid of this route.
Output of netstat -n -r
Routing tables

Internet:
Destination        Gateway            Flags     Refs     Use    Mtu  Interface
default            10.0.0.1           UGS         0       28   1500  rtk0
10/24              link#2             UC          3        0   1500  rtk0
10.0.0.1           00:c0:f0:75:b7:19  UHLc        2     4653   1500  rtk0
127                127.0.0.1          UGRS        0        0  33228  lo0
127.0.0.1          127.0.0.1          UH          1        0  33228  lo0

XNS:
Destination        Gateway            Flags     Refs     Use    Mtu  Interface

ISO:
Destination        Gateway            Flags     Refs     Use    Mtu  Interface

X.25:
Destination        Gateway            Flags     Refs     Use    Mtu  Interface

AppleTalk:
Destination        Gateway            Flags     Refs     Use    Mtu  Interface

Internet6:
Destination                   Gateway                   Flags     Refs     Use    Mtu  Interface
::/104                        ::1                       UGRS        0        0  33228  lo0 =>
::/96                         ::1                       UGRS        0        0  33228  lo0
::1                           ::1                       UH         12        0  33228  lo0
::127.0.0.0/104               ::1                       UGRS        0        0  33228  lo0
::224.0.0.0/100               ::1                       UGRS        0        0  33228  lo0
::255.0.0.0/104               ::1                       UGRS        0        0  33228  lo0
::ffff:0.0.0.0/96             ::1                       UGRS        0        0  33228  lo0
2002::/24                     ::1                       UGRS        0        0  33228  lo0
2002:7f00::/24                ::1                       UGRS        0        0  33228  lo0
2002:e000::/20                ::1                       UGRS        0        0  33228  lo0
2002:ff00::/24                ::1                       UGRS        0        0  33228  lo0
fe80::/10                     ::1                       UGRS        0        0  33228  lo0
fe80::%ex0/64                 link#1                    UC          0        0   1500  ex0
fe80::%rtk0/64                link#2                    UC          0        0   1500  rtk0
fe80::%lo0/64                 fe80::1%lo0               U           0        0  33228  lo0
fec0::/10                     ::1                       UGRS        0        0  33228  lo0
ff01::/32                     ::1                       U           0        0  33228  lo0
ff02::%ex0/32                 link#1                    UC          0        0   1500  ex0
ff02::%rtk0/32                link#2                    UC          0        0   1500  rtk0
ff02::%lo0/32                 fe80::1%lo0               UC          0        0  33228  lo0
---------------------------------------------
Contents of /etc/resolv.conf
* The following section lists DNS setup.
* If you can browse by IP address, but not name, suspect
* a DNS problem.
nameserver 63.203.35.55
nameserver 206.13.28.12
---------------------------------------------
* The following section lists /etc/ppp/options.
* You should have NOTHING in that file.
Contents of /etc/ppp/options
---------------------------------------------
* The following section identifies your Ethernet interface
* and user name.  Some ISP's need 'username'; others
* need 'username@isp.com'.  Try both
ETH=ex0; USER=dslreguser
---------------------------------------------
* The following section shows the pppd command we will invoke
pppd invocation
 /usr/sbin/pppd pty '/usr/pkg/sbin/pppoe -p /var/run/pppoe.conf-adsl.pid.pppoe -I ex0 -T 80 -U  -m 1412 -C 62031020042225-rback1.pltn13  '  noipdefault noauth default-asyncmap defaultroute hide-password nodetach usepeerdns mtu 1492 mru 1492 noaccomp noccp nobsdcomp nodeflate nopcomp novj novjccomp user dslreguser lcp-echo-interval 20 lcp-echo-failure 3   debug
---------------------------------------------
Using interface ppp0
Connect: ppp0 <--> /dev/ttyp1
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xd989a61a>]
LCP: timeout sending Config-Requests
Connection terminated.
Waiting for 1 child processes...
  script /usr/pkg/sbin/pppoe -p /var/run/pppoe.conf-adsl.pid.pppoe -I ex0 -T 80 -U  -m 1412 -C 62031020042225-rback1.pltn13   -D /tmp/pppoe-debug-1478/pppoe-debug.txt-0, pid 1528
pppoe: Timeout waiting for PADO packets
Waiting for 1 child processes...
  script /usr/pkg/sbin/pppoe -p /var/run/pppoe.conf-adsl.pid.pppoe -I ex0 -T 80 -U  -m 1412 -C 62031020042225-rback1.pltn13   -D /tmp/pppoe-debug-1478/pppoe-debug.txt-0, pid 1528
Script /usr/pkg/sbin/pppoe -p /var/run/pppoe.conf-adsl.pid.pppoe -I ex0 -T 80 -U  -m 1412 -C 62031020042225-rback1.pltn13   -D /tmp/pppoe-debug-1478/pppoe-debug.txt-0 finished (pid 1528), status = 0x100
---------------------------------------------
* The following section is an extract from your log.
* Look for error messages from pppd, such as
* a lack of kernel support for PPP, authentication failure
* etc.
Extract from /var/log/messages
Sep 14 16:18:27 pato pppd[531]: pppd 2.4.0 started by alexis, uid 0
Sep 14 16:18:27 pato pppd[531]: Using interface ppp0
Sep 14 16:18:27 pato pppd[531]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 16:18:27 pato pppoe[533]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 16:18:58 pato pppd[531]: LCP: timeout sending Config-Requests 
Sep 14 16:18:58 pato pppd[531]: Connection terminated.
Sep 14 16:19:02 pato pppoe[533]: Timeout waiting for PADO packets
Sep 14 16:19:02 pato pppd[531]: Exit.
Sep 14 16:22:27 pato pppd[592]: pppd 2.4.0 started by alexis, uid 0
Sep 14 16:22:27 pato pppd[592]: Using interface ppp0
Sep 14 16:22:27 pato pppd[592]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 16:22:27 pato pppoe[594]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 16:22:58 pato pppd[592]: LCP: timeout sending Config-Requests 
Sep 14 16:22:58 pato pppd[592]: Connection terminated.
Sep 14 16:23:02 pato pppoe[594]: Timeout waiting for PADO packets
Sep 14 16:23:02 pato pppd[592]: Exit.
Sep 14 16:28:33 pato pppd[647]: pppd 2.4.0 started by alexis, uid 0
Sep 14 16:28:33 pato pppd[647]: Using interface ppp0
Sep 14 16:28:33 pato pppd[647]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 16:28:33 pato pppoe[649]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 16:29:04 pato pppd[647]: LCP: timeout sending Config-Requests 
Sep 14 16:29:04 pato pppd[647]: Connection terminated.
Sep 14 16:29:08 pato pppoe[649]: Timeout waiting for PADO packets
Sep 14 16:29:08 pato pppd[647]: Exit.
Sep 14 16:53:04 pato pppd[728]: pppd 2.4.0 started by alexis, uid 0
Sep 14 16:53:04 pato pppd[728]: Using interface ppp0
Sep 14 16:53:04 pato pppd[728]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 16:53:04 pato pppoe[730]: Interface ex0 is not up 
Sep 14 16:53:04 pato pppd[728]: Modem hangup
Sep 14 16:53:04 pato pppd[728]: Connection terminated.
Sep 14 16:53:04 pato pppd[728]: Exit.
Sep 14 16:55:24 pato pppd[785]: pppd 2.4.0 started by alexis, uid 0
Sep 14 16:55:24 pato pppd[785]: Using interface ppp0
Sep 14 16:55:24 pato pppd[785]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 16:55:24 pato pppoe[787]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 16:55:55 pato pppd[785]: LCP: timeout sending Config-Requests 
Sep 14 16:55:55 pato pppd[785]: Connection terminated.
Sep 14 16:55:59 pato pppoe[787]: Timeout waiting for PADO packets
Sep 14 16:55:59 pato pppd[785]: Exit.
Sep 14 17:13:48 pato pppd[859]: pppd 2.4.0 started by alexis, uid 0
Sep 14 17:13:48 pato pppd[859]: Using interface ppp0
Sep 14 17:13:48 pato pppd[859]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 17:13:48 pato pppoe[861]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 17:14:19 pato pppd[859]: LCP: timeout sending Config-Requests 
Sep 14 17:14:19 pato pppd[859]: Connection terminated.
Sep 14 17:14:23 pato pppoe[861]: Timeout waiting for PADO packets
Sep 14 17:14:23 pato pppd[859]: Exit.
Sep 14 17:28:38 pato pppd[1098]: pppd 2.4.0 started by alexis, uid 0
Sep 14 17:28:38 pato pppd[1098]: Using interface ppp0
Sep 14 17:28:38 pato pppd[1098]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 17:28:38 pato pppoe[1100]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 17:29:09 pato pppd[1098]: LCP: timeout sending Config-Requests 
Sep 14 17:29:09 pato pppd[1098]: Connection terminated.
Sep 14 17:29:13 pato pppoe[1100]: Timeout waiting for PADO packets
Sep 14 17:29:13 pato pppd[1098]: Exit.
Sep 14 17:32:50 pato pppd[1303]: pppd 2.4.0 started by alexis, uid 0
Sep 14 17:32:50 pato pppd[1303]: Using interface ppp0
Sep 14 17:32:50 pato pppd[1303]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 17:32:50 pato pppoe[1305]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 17:33:21 pato pppd[1303]: LCP: timeout sending Config-Requests 
Sep 14 17:33:21 pato pppd[1303]: Connection terminated.
Sep 14 17:33:25 pato pppoe[1305]: Timeout waiting for PADO packets
Sep 14 17:33:25 pato pppd[1303]: Exit.
Sep 14 17:33:45 pato pppd[1527]: pppd 2.4.0 started by alexis, uid 0
Sep 14 17:33:45 pato pppd[1527]: Using interface ppp0
Sep 14 17:33:45 pato pppd[1527]: Connect: ppp0 <--> /dev/ttyp1
Sep 14 17:33:45 pato pppoe[1529]: Interface=ex0 HWaddr=00:50:04:61:10:DA Device=/dev/bpf0 Buffer size=8192
Sep 14 17:34:16 pato pppd[1527]: LCP: timeout sending Config-Requests 
Sep 14 17:34:16 pato pppd[1527]: Connection terminated.
Sep 14 17:34:20 pato pppoe[1529]: Timeout waiting for PADO packets
Sep 14 17:34:20 pato pppd[1527]: Exit.
Sat Sep 14 17:34:20 PDT 2002
---------------------------------------------
* The following section is a dump of the packets
* sent and received by rp-pppoe.  If you don't see
* any output, it's an Ethernet driver problem.  If you only
* see three PADI packets and nothing else, check your cables
* and modem.  Make sure the modem lights flash when you try
* to connect.  Check that your Ethernet card is in
* half-duplex, 10Mb/s mode.  If all else fails,
* try using pppoe-sniff.
rp-pppoe debugging dump
rp-pppoe-3.3
17:33:45.820 SENT PPPoE Discovery (8863) PADI sess-id 0 length 12
SourceAddr 00:50:04:61:10:da DestAddr ff:ff:ff:ff:ff:ff
01 01 00 00 01 03 00 04 f9 05 00 00               ............

17:33:45.820 RCVD PPPoE Discovery (8863) PADI sess-id 0 length 12
SourceAddr 00:50:04:61:10:da DestAddr ff:ff:ff:ff:ff:ff
01 01 00 00 01 03 00 04 f9 05 00 00               ............

17:33:50.830 SENT PPPoE Discovery (8863) PADI sess-id 0 length 12
SourceAddr 00:50:04:61:10:da DestAddr ff:ff:ff:ff:ff:ff
01 01 00 00 01 03 00 04 f9 05 00 00               ............

17:33:50.830 RCVD PPPoE Discovery (8863) PADI sess-id 0 length 12
SourceAddr 00:50:04:61:10:da DestAddr ff:ff:ff:ff:ff:ff
01 01 00 00 01 03 00 04 f9 05 00 00               ............

17:33:50.853 RCVD PPPoE Discovery (8863) PADO sess-id 0 length 49
SourceAddr 00:10:67:00:b5:a0 DestAddr 00:50:04:61:10:da
01 01 00 00 01 03 00 04 f9 05 00 00 01 02 00 1d   ................
36 32 30 31 31 30 32 30 30 34 32 37 39 31 2d 72   62011020042791-r
62 61 63 6b 31 31 2e 73 6e 74 63 30 31 01 01 00   back11.sntc01...
00                                                .

17:34:00.860 SENT PPPoE Discovery (8863) PADI sess-id 0 length 12
SourceAddr 00:50:04:61:10:da DestAddr ff:ff:ff:ff:ff:ff
01 01 00 00 01 03 00 04 f9 05 00 00               ............

17:34:00.860 RCVD PPPoE Discovery (8863) PADI sess-id 0 length 12
SourceAddr 00:50:04:61:10:da DestAddr ff:ff:ff:ff:ff:ff
01 01 00 00 01 03 00 04 f9 05 00 00               ............

17:34:00.886 RCVD PPPoE Discovery (8863) PADO sess-id 0 length 49
SourceAddr 00:10:67:00:b5:a0 DestAddr 00:50:04:61:10:da
01 01 00 00 01 03 00 04 f9 05 00 00 01 02 00 1d   ................
36 32 30 31 31 30 32 30 30 34 32 37 39 31 2d 72   62011020042791-r
62 61 63 6b 31 31 2e 73 6e 74 63 30 31 01 01 00   back11.sntc01...
00                                                .