ppp+pppoe+freeradius
Hello ppl,
I'm trying to setup pppoe-server on Debian-3.1-sarge with
kernel-2.6.10+mppe. But it seems that current ppp package comes without
radius plugin. Of course when I'm try to setup without radius
authentication everything works fine. I also try to setup with non-debian
packages, so I download ppp-2.4.3 from cvs, rp-pppoe-3.5 from
www.roaringpenguin.com, radiusclient-0.3.2 from
ftp://ftp.cityline.net/pub/radiusclient/, and just for sport I changed my
kernel ver to 2.4.29 with buildin support for ppp*. Everything was
compiled and configured then all servers, clients and etc was started.
pppoe-server was started with this options: -k -s -L x.x.x.x -N 2000 -I
eth1 -R x.x.x.x
The I try to pppoe from WinXP machine, I get this in /var/log/syslog:
Feb 27 02:06:05 moscow pppoe-server[18146]: Session 1 created for client
00:04:61:66:c2:ee (x.x.x.x) on eth1 using Service-Name ''
Feb 27 02:06:05 moscow pppd[18146]: Plugin /etc/ppp/plugins/rp-pppoe.so
loaded.
Feb 27 02:06:05 moscow pppd[18146]: RP-PPPoE plugin version 3.5 compiled
against pppd 2.4.3
Feb 27 02:06:05 moscow pppd[18146]: Plugin
/usr/local/lib/pppd/2.4.3/radius.so loaded.
Feb 27 02:06:05 moscow pppd[18146]: RADIUS plugin initialized.
Feb 27 02:06:05 moscow pppd[18146]: pppd 2.4.3 started by root, uid 0
Feb 27 02:06:05 moscow pppd[18146]: using channel 6
Feb 27 02:06:05 moscow pppd[18146]: Using interface ppp0
Feb 27 02:06:05 moscow pppd[18146]: Connect: ppp0 <--> eth1
Feb 27 02:06:05 moscow pppd[18146]: Couldn't increase MTU to 1500
Feb 27 02:06:05 moscow pppd[18146]: Couldn't increase MRU to 1500
Feb 27 02:06:05 moscow pppd[18146]: rcvd [LCP ConfReq id=0x0 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:07 moscow pppd[18146]: rcvd [LCP ConfReq id=0x1 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:10 moscow pppd[18146]: rcvd [LCP ConfReq id=0x2 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:14 moscow pppd[18146]: rcvd [LCP ConfReq id=0x3 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:18 moscow pppd[18146]: rcvd [LCP ConfReq id=0x4 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:22 moscow pppd[18146]: rcvd [LCP ConfReq id=0x5 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:26 moscow pppd[18146]: rcvd [LCP ConfReq id=0x6 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:30 moscow pppd[18146]: rcvd [LCP ConfReq id=0x7 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:34 moscow pppd[18146]: rcvd [LCP ConfReq id=0x8 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:38 moscow pppd[18146]: rcvd [LCP ConfReq id=0x9 <mru 1480>
<magic 0x5cc22e01> <callback CBCP>] 00 00 00 00 00 00 00 00 00 00 00 00 00
00 00 00 00 00 00 00 00
Feb 27 02:06:42 moscow pppoe-server[18143]: Sent PADT
Feb 27 02:06:42 moscow pppd[18146]: Terminating on signal 15
Next time pppoe-server was started with this options:
-L x.x.x.x -N 2000 -I eth1 -R x.x.x.x
Then i get this in /var/log/syslog:
Feb 27 02:07:07 moscow pppoe-server[18153]: Session 1 created for client
00:04:61:66:c2:ee (x.x.x.x) on eth1 using Service-Name ''
Feb 27 02:07:07 moscow pppd[18153]: Plugin
/usr/local/lib/pppd/2.4.3/radius.so loaded.
Feb 27 02:07:07 moscow pppd[18153]: RADIUS plugin initialized.
Feb 27 02:07:07 moscow pppd[18153]: pppd 2.4.3 started by root, uid 0
Feb 27 02:07:07 moscow pppd[18153]: using channel 7
Feb 27 02:07:07 moscow pppd[18153]: Using interface ppp1
Feb 27 02:07:07 moscow pppd[18153]: Connect: ppp1 <--> /dev/pts/1
Feb 27 02:07:08 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:09 moscow pppd[18153]: rcvd [LCP ConfReq id=0x1 <mru 1480>
<magic 0x737007e6> <callback CBCP>]
Feb 27 02:07:09 moscow pppd[18153]: sent [LCP ConfRej id=0x1 <callback CBCP>]
Feb 27 02:07:11 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:14 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:16 moscow pppd[18153]: rcvd [LCP ConfReq id=0x3 <mru 1480>
<magic 0x737007e6> <callback CBCP>]
Feb 27 02:07:16 moscow pppd[18153]: sent [LCP ConfRej id=0x3 <callback CBCP>]
Feb 27 02:07:17 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:23 moscow last message repeated 2 times
Feb 27 02:07:24 moscow pppd[18153]: rcvd [LCP ConfReq id=0x5 <mru 1480>
<magic 0x737007e6> <callback CBCP>]
Feb 27 02:07:24 moscow pppd[18153]: sent [LCP ConfRej id=0x5 <callback CBCP>]
Feb 27 02:07:26 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:29 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:32 moscow pppd[18153]: rcvd [LCP ConfReq id=0x7 <mru 1480>
<magic 0x737007e6> <callback CBCP>]
Feb 27 02:07:32 moscow pppd[18153]: sent [LCP ConfRej id=0x7 <callback CBCP>]
Feb 27 02:07:32 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:35 moscow pppd[18153]: sent [LCP ConfReq id=0x1 <mru 1472>
<auth pap> <magic 0x1ec6094b>]
Feb 27 02:07:38 moscow pppd[18153]: LCP: timeout sending Config-Requests
Feb 27 02:07:38 moscow pppd[18153]: Connection terminated.
Feb 27 02:07:38 moscow pppd[18153]: using channel 8
Feb 27 02:07:38 moscow pppd[18153]: Using interface ppp1
Feb 27 02:07:38 moscow pppd[18153]: Connect: ppp1 <--> /dev/pts/2
Feb 27 02:07:38 moscow pppd[18153]: Waiting for 2 child processes...
Feb 27 02:07:38 moscow pppd[18153]: script /usr/sbin/pppoe -n -I eth1 -e
1:00:04:61:66:c2:ee -S '', pid 18155
Feb 27 02:07:38 moscow pppd[18153]: script /usr/sbin/pppoe -n -I eth1 -e
1:00:04:61:66:c2:ee -S '', pid 18154
Feb 27 02:07:39 moscow pppd[18153]: sent [LCP ConfReq id=0x2 <mru 1472>
<auth pap> <magic 0xe9c57317>]
Feb 27 02:07:42 moscow pppd[18153]: sent [LCP ConfReq id=0x2 <mru 1472>
<auth pap> <magic 0xe9c57317>]
Feb 27 02:07:43 moscow pppd[18153]: sending SIGTERM to process 18155
Feb 27 02:07:43 moscow pppd[18153]: sending SIGTERM to process 18154
Feb 27 02:07:43 moscow pppd[18153]: tcflush failed: Bad file descriptor
Feb 27 02:07:43 moscow pppd[18153]: Exit.
Feb 27 02:07:43 moscow pppoe-server[18151]: Session 1 closed for client
00:04:61:66:c2:ee (x.x.x.x) on eth1
Feb 27 02:07:43 moscow pppoe-server[18151]: Sent PADT
Feb 27 02:07:43 moscow pppoe-server[18151]: Sent PADT
In both cases I didn't get any attempt for connection from radius-plugin
in /var/log/freeradius/radius.log, when I try to connect with radtest
everything is ok, and in radius.log I get msg-entry:
"Sat Feb 26 06:07:02 2005 : Auth: Login OK: [user/pass] (from client
localhost port 1812)"
Debian packages:
ppp_2.4.2+20040428-6
rp-pppoe-3.5
radiusclient-0.3.2
freeradius-1.0.1
Here is pppoe-server-options:
debug
mtu 1472
mru 1472
require-pap
default-asyncmap
proxyarp
ktune
lcp-echo-interval 20
lcp-echo-failure 2
ms-dns x.x.x.x
ms-dns x.x.x.x
#plugin radius.so
plugin /usr/local/lib/pppd/2.4.3/radius.so
nobsdcomp
noccp
noendpoint
noipdefault
noipx
novj
receive-all
I'm little confused why I don't get any attempt for authentication with
freeradius from ppp radius-plugin when I'm pppoe from WinXP machine?
Please guys say some words about this, any help will be appreciated. I'm
googling couple of days and there isn't much things about this issue.
Thanks in advanced.
Regards,
E.A.
--------------------------------------------------------------
SELLINET Internet Services Provider - http://www.sellinet.net/
Reply to: