Date: Wed, 19 Jun 2002 20:42:08 -0500 (CDT) From: <rob@the-rob.com> To: <net@freebsd.org> Subject: [Fwd: Re:Issues_with_PPPoE_and_4.6] Message-ID: <4382.216.170.186.25.1024537328.squirrel@www.soho.berbee.com>
next in thread | raw e-mail | index | archive | help
forgot reply to all.
-------- Original Message --------
Subject: Re:Issues_with_PPPoE_and_4.6
From: <rob@the-rob.com>
To: <julian@elischer.org>
> unfortunatly it doesn;t look like these were SIMULTANEOUS sessions..
> when you examine the timestamps it appears that they do not cover the
> same connection attempt...
>
> the tcpdump covers 19:13:12 -> 19:13:57.
> and the ppp log covers 19:13:39 -> 19:16:00
>
> which overlaps, but th e PADI negotioation all happens between 19:13:34
> and 19:13:39.4 which is all before the ppp log started..
here it is again
tcpdump 20:30:56 -> 20:31:37
/var/log/ppp.log 20:30:49 -> 20:31:44
Here is the dump and the ppp.conf at the end just to make sure I have the
logging options setup as you requested.
20:30:56.683293 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x55f] LCP 20: Conf-Req(5), MRU=1492, Auth-Prot PAP, Magic-Num=
76ff7611
20:30:58.684063 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x55f] LCP 20: Conf-Req(6), MRU=1492, Auth-Prot PAP, Magic-Num=
76ff7611
20:31:00.763678 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x55f] LCP 20: Conf-Req(7), MRU=1492, Auth-Prot PAP, Magic-Num=
76ff7611
20:31:02.764955 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x55f] LCP 20: Conf-Req(8), MRU=1492, Auth-Prot PAP, Magic-Num=
76ff7611
20:31:03.973960 0:4:76:b8:26:7c Broadcast arp 42: arp who-has 10.0.0.1
(20:63:61:72:72:69) tell 10.0.0.1
20:31:04.319409 0:4:76:b8:26:7c Broadcast 8863 32: PPPoE PADI [Host-Uniq
UTF8]
20:31:04.766025 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x55f] LCP 20: Conf-Req(9), MRU=1492, Auth-Prot PAP, Magic-Num=
76ff7611
20:31:06.313453 0:4:76:b8:26:7c Broadcast 8863 32: PPPoE PADI [Host-Uniq
UTF8]
20:31:06.339572 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8863 75: PPPoE PADO
[Host- Uniq UTF8] [Service-Name] [AC-Name "miwi-6400-inet-nrp0"]
[AC-Cookie UTF8]
20:31:06.339656 0:4:76:b8:26:7c 0:2:4b:a4:b7:87 8863 75: PPPoE PADR
[Host- Uniq UTF8] [AC-Cookie UTF8] [AC-Name "miwi-6400-inet-nrp0"
]
20:31:06.777365 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x55f] LCP 20: Conf-Req(10), MRU=1492, Auth-Prot PAP, Magic-Num
=76ff7611
20:31:06.818273 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8863 75: PPPoE PADS [ses
0x560] [Host-Uniq UTF8] [AC-Cookie UTF8] [AC-Name "miwi-640
0-inet-nrp0"]
20:31:06.848555 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(1), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:08.777901 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8863 60: PPPoE PADT [ses
0x55f]
20:31:08.895167 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(2), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:09.365445 0:4:76:b8:26:7c 0:2:4b:a4:b7:87 8863 38: PPPoE PADT [ses
0x560] [Generic-Error "session closed"]
20:31:10.893737 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(3), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:12.894763 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(4), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:14.895535 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(5), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:16.896818 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(6), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:18.897602 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(7), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:19.318397 0:4:76:b8:26:7c Broadcast 8863 32: PPPoE PADI [Host-Uniq
UTF8]
20:31:20.898634 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(8), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:21.313674 0:4:76:b8:26:7c Broadcast 8863 32: PPPoE PADI [Host-Uniq
UTF8]
20:31:21.485248 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8863 75: PPPoE PADO
[Host- Uniq UTF8] [Service-Name] [AC-Name "miwi-6400-inet-nrp0"]
[AC-Cookie UTF8]
20:31:21.485325 0:4:76:b8:26:7c 0:2:4b:a4:b7:87 8863 75: PPPoE PADR
[Host- Uniq UTF8] [AC-Cookie UTF8] [AC-Name "miwi-6400-inet-nrp0"
]
20:31:21.853316 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8863 75: PPPoE PADS [ses
0x562] [Host-Uniq UTF8] [AC-Cookie UTF8] [AC-Name "miwi-640
0-inet-nrp0"]
20:31:21.875986 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(1), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:22.899403 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(9), MRU=1492, Auth-Prot PAP, Magic-Num=
76ffbd03
20:31:23.876023 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(2), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:24.365475 0:4:76:b8:26:7c 0:2:4b:a4:b7:87 8863 38: PPPoE PADT [ses
0x562] [Generic-Error "session closed"]
20:31:24.900197 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x560] LCP 20: Conf-Req(10), MRU=1492, Auth-Prot PAP, Magic-Num
=76ffbd03
20:31:25.876806 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(3), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:26.901464 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8863 60: PPPoE PADT [ses
0x560]
20:31:27.878089 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(4), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:29.878869 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(5), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:31.879407 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(6), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:33.880174 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(7), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:35.880966 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(8), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
20:31:37.881996 0:2:4b:a4:b7:87 0:4:76:b8:26:7c 8864 60: PPPoE [ses
0x562] LCP 20: Conf-Req(9), MRU=1492, Auth-Prot PAP, Magic-Num=
76fff7b1
%less ppp
Jun 19 20:30:49 PITA ppp[72]: tun0: Phase: deflink: hangup -> opening Jun
19 20:30:49 PITA ppp[72]: tun0: Phase: deflink: Enter pause (30) for
redialing.
Jun 19 20:31:04 PITA ppp[309]: Phase: Using interface: tun1
Jun 19 20:31:04 PITA ppp[309]: Phase: deflink: Created in closed state
Jun 19 20:31:04 PITA ppp[309]: tun1: Command: default: add default
HISADDR Jun 19 20:31:04 PITA ppp[309]: tun1: Command: default: enable dns
Jun 19 20:31:04 PITA ppp[309]: tun1: Command: tds: set authname rzietlow2
Jun 19 20:31:04 PITA ppp[309]: tun1: Command: tds: set authkey ********
Jun 19 20:31:04 PITA ppp[310]: tun1: Phase: PPP Started (ddial mode). Jun
19 20:31:04 PITA ppp[310]: tun1: Phase: bundle: Establish
Jun 19 20:31:04 PITA ppp[310]: tun1: Phase: deflink: closed -> opening
Jun 19 20:31:04 PITA ppp[310]: tun1: Phase: deflink: Connected!
Jun 19 20:31:04 PITA ppp[310]: tun1: Phase: deflink: opening -> dial Jun
19 20:31:04 PITA ppp[310]: tun1: Phase: deflink: dial -> carrier Jun 19
20:31:07 PITA ppp[310]: tun1: Phase: Received NGM_PPPOE_ACNAME (hook
"miwi-6400-inet-n<F8><F8><BF><BF><AF><E2>^G^HM-^@<B1> ^H
^P^P^K^H")
Jun 19 20:31:08 PITA ppp[310]: tun1: Phase: Received NGM_PPPOE_<11> (hook
"`^E^H^Hh^P^K^H")
Jun 19 20:31:09 PITA ppp[310]: tun1: Phase: deflink: Disconnected! Jun 19
20:31:09 PITA ppp[310]: tun1: Phase: deflink: carrier -> hangup Jun 19
20:31:09 PITA ppp[310]: tun1: Phase: deflink: Connect time: 5 secs: 0
octets in, 0 octets out
Jun 19 20:31:09 PITA ppp[310]: tun1: Phase: deflink: : 0 packets in, 0
packets out
Jun 19 20:31:09 PITA ppp[310]: tun1: Phase: total 0 bytes/sec, peak 0
bytes/sec on Wed Jun 19 20:31:04 2002
Jun 19 20:31:09 PITA ppp[310]: tun1: Phase: deflink: hangup -> opening
Jun 19 20:31:09 PITA ppp[310]: tun1: Phase: deflink: Enter pause (30) for
redialing.
Jun 19 20:31:19 PITA ppp[72]: tun0: Phase: deflink: Connected!
Jun 19 20:31:19 PITA ppp[72]: tun0: Phase: deflink: opening -> dial Jun
19 20:31:19 PITA ppp[72]: tun0: Phase: deflink: dial -> carrier Jun 19
20:31:22 PITA ppp[72]: tun0: Phase: Received NGM_PPPOE_ACNAME (hook
"miwi-6400-inet-n<BC><F9><BF><BF><AF><E2>^G^HM-^@<B1> ^H^
P ^K^H")
Jun 19 20:31:23 PITA ppp[72]: tun0: Phase: Received NGM_PPPOE_<11> (hook
"b^E^H^Hh ^K^H")
Jun 19 20:31:24 PITA ppp[72]: tun0: Phase: deflink: Disconnected!
Jun 19 20:31:24 PITA ppp[72]: tun0: Phase: deflink: carrier -> hangup Jun
19 20:31:24 PITA ppp[72]: tun0: Phase: deflink: Connect time: 5 secs: 0
octets in, 0 octets out
Jun 19 20:31:24 PITA ppp[72]: tun0: Phase: deflink: : 0 packets in, 0
packets out
Jun 19 20:31:24 PITA ppp[72]: tun0: Phase: total 0 bytes/sec, peak 0
bytes/sec on Wed Jun 19 20:31:19 2002
Jun 19 20:31:24 PITA ppp[72]: tun0: Phase: deflink: hangup -> opening Jun
19 20:31:24 PITA ppp[72]: tun0: Phase: deflink: Enter pause (30) for
redialing.
Jun 19 20:31:39 PITA ppp[310]: tun1: Phase: deflink: Connected!
Jun 19 20:31:39 PITA ppp[310]: tun1: Phase: deflink: opening -> dial Jun
19 20:31:39 PITA ppp[310]: tun1: Phase: deflink: dial -> carrier Jun 19
20:31:42 PITA ppp[310]: tun1: Phase: Received NGM_PPPOE_ACNAME (hook
"miwi-6400-inet-n<F8><F8><BF><BF><AF><E2>^G^HM-^@<B1> ^H
^P^P^K^H")
Jun 19 20:31:43 PITA ppp[310]: tun1: Phase: Received NGM_PPPOE_<11> (hook
"c^E^H^Hh^P^K^H")
Jun 19 20:31:44 PITA ppp[310]: tun1: Phase: deflink: Disconnected! Jun 19
20:31:44 PITA ppp[310]: tun1: Phase: deflink: carrier -> hangup Jun 19
20:31:44 PITA ppp[310]: tun1: Phase: deflink: Connect time: 5 secs: 0
octets in, 0 octets out
Jun 19 20:31:44 PITA ppp[310]: tun1: Phase: deflink: : 0 packets in, 0
packets out
Jun 19 20:31:44 PITA ppp[310]: tun1: Phase: total 0 bytes/sec, peak 0
bytes/sec on Wed Jun 19 20:31:39 2002
ppp (END)
PITA# less /etc/ppp/ppp.conf
#################################################################
# PPP Sample Configuration File
# Originally written by Toshiharu OHNO
# Simplified 5/14/1999 by wself@cdrom.com
#
# See /usr/share/examples/ppp/ for some examples
#
# $FreeBSD: src/etc/ppp/ppp.conf,v 1.2.2.5 2001/07/13 10:55:23 brian Exp
$ #################################################################
default:
#ppp over ethernet
set device PPPoE:xl0:
set speed sync
set mru 1492
set mtu 1492
set ctsrts off
# monitor line quality
enable lqr
# log just a bit
set log +lcp ipcp phase tun command ccp
# insert default route upon connection
add default HISADDR
# download /etc/resolv.conf
enable dns
tds:
set authname <login>
set authkey <password>
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?4382.216.170.186.25.1024537328.squirrel>