[pptp-server] 128 bit encryption fails
Steve Wood
swood at collectrite.com
Thu Oct 5 10:58:37 CDT 2000
Hi all,
Something weird started happening to my pptp server yesterday and I have no
idea what caused it. I have been running my pptpd server for 50 days with
no problems whatsoever but suddenly yesterday my win98/2000 clients stopped
connecting to my server with a (571 encryption not supported) error. If I
do not have the 128 bit upgrade on my win box then I can connect fine with
40 bit encryption but if it is installed i have to disable all encryption to
connect. I haven't made any changes and I checked all my modules and they
are all loaded. Has anybody else seen this strange behavior before?
Here is a typical win2000/98se session trying to connect with 128bit
encryption. I'm not sure what the error with select() is but maybe this is
my problem?
--------------------------------BEGIN--------------------------------------
Oct 4 22:13:46 spock pptpd[2818]: MGR: Reaped child 2870
Oct 4 23:24:29 spock pptpd[2958]: MGR: Launching /usr/local/sbin/pptpctrl
to handle client
Oct 4 23:24:29 spock pptpd[2958]: CTRL: local address = 198.186.150.101
Oct 4 23:24:29 spock pptpd[2958]: CTRL: remote address = 198.186.150.112
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Client 209.136.33.71 control
connection started
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Received PPTP Control Message
(type: 1)
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Made a START CTRL CONN RPLY packet
Oct 4 23:24:29 spock pptpd[2958]: CTRL: I wrote 156 bytes to the client.
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Sent packet to client
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Received PPTP Control Message
(type: 7)
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Set parameters to 1525 maxbps, 64
window size
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Made a OUT CALL RPLY packet
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Starting call (launching pppd,
opening GRE)
Oct 4 23:24:29 spock pptpd[2958]: CTRL: pty_fd = 4
Oct 4 23:24:29 spock pptpd[2958]: CTRL: tty_fd = 5
Oct 4 23:24:29 spock pptpd[2958]: CTRL: I wrote 32 bytes to the client.
Oct 4 23:24:29 spock pptpd[2959]: CTRL (PPPD Launcher): Connection speed =
115200
Oct 4 23:24:29 spock pptpd[2959]: CTRL (PPPD Launcher): local address =
198.186.150.101
Oct 4 23:24:29 spock pptpd[2959]: CTRL (PPPD Launcher): remote address =
198.186.150.112
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Sent packet to client
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Received PPTP Control Message
(type: 15)
Oct 4 23:24:30 spock pptpd[2958]: CTRL: Got a SET LINK INFO packet with
standard ACCMs
Oct 4 23:24:30 spock pptpd[2958]: GRE: Discarding duplicate packet
Oct 4 23:24:31 spock pptpd[2958]: CTRL: Received PPTP Control Message
(type: 15)
Oct 4 23:24:31 spock pptpd[2958]: CTRL: Ignored a SET LINK INFO packet with
real ACCMs!
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Received PPTP Control Message
(type: 15)
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Ignored a SET LINK INFO packet with
real ACCMs!
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Received PPTP Control Message
(type: 12)
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Made a CALL DISCONNECT RPLY packet
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Received CALL CLR request (closing
call)
Oct 4 23:24:32 spock pptpd[2958]: CTRL: I wrote 148 bytes to the client.
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Sent packet to client
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Error with select(), quitting
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Client 209.136.33.71 control
connection finished
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Exiting now
---------------------------------END---------------------------------------
here are the corresponding entries in my messages file:
--------------------------------BEGIN--------------------------------------
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Client 209.136.33.71 control
connection started
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Client 209.136.33.71 control
connection started
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Starting call (launching pppd,
opening GRE)
Oct 4 23:24:29 spock pptpd[2958]: CTRL: Starting call (launching pppd,
opening GRE)
Oct 4 23:24:29 spock kernel: CSLIP: code copyright 1989 Regents of the
University of California
Oct 4 23:24:29 spock kernel: CSLIP: code copyright 1989 Regents of the
University of California
Oct 4 23:24:30 spock kernel: PPP: version 2.3.7 (demand dialling)
Oct 4 23:24:30 spock kernel: PPP: version 2.3.7 (demand dialling)
Oct 4 23:24:30 spock kernel: PPP line discipline registered.
Oct 4 23:24:30 spock kernel: PPP line discipline registered.
Oct 4 23:24:30 spock kernel: registered device ppp0
Oct 4 23:24:30 spock kernel: registered device ppp0
Oct 4 23:24:30 spock pppd[2959]: pppd 2.3.11 started by root, uid 0
Oct 4 23:24:30 spock pppd[2959]: pppd 2.3.11 started by root, uid 0
Oct 4 23:24:30 spock pppd[2959]: Using interface ppp0
Oct 4 23:24:30 spock pppd[2959]: Using interface ppp0
Oct 4 23:24:30 spock pppd[2959]: Connect: ppp0 <--> /dev/pts/0
Oct 4 23:24:30 spock pppd[2959]: Connect: ppp0 <--> /dev/pts/0
Oct 4 23:24:30 spock pptpd[2958]: GRE: Discarding duplicate packet
Oct 4 23:24:30 spock pptpd[2958]: GRE: Discarding duplicate packet
Oct 4 23:24:31 spock pptpd[2958]: CTRL: Ignored a SET LINK INFO packet with
real ACCMs!
Oct 4 23:24:31 spock pptpd[2958]: CTRL: Ignored a SET LINK INFO packet with
real ACCMs!
Oct 4 23:24:31 spock kernel: PPP BSD Compression module registered
Oct 4 23:24:31 spock kernel: PPP BSD Compression module registered
Oct 4 23:24:32 spock kernel: PPP MPPE compression module registered
Oct 4 23:24:32 spock kernel: PPP MPPE compression module registered
Oct 4 23:24:32 spock kernel: PPP Deflate Compression module registered
Oct 4 23:24:32 spock kernel: PPP Deflate Compression module registered
Oct 4 23:24:32 spock pppd[2959]: MSCHAP-v2 peer authentication succeeded
for Steve Wood
Oct 4 23:24:32 spock pppd[2959]: MSCHAP-v2 peer authentication succeeded
for Steve Wood
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Ignored a SET LINK INFO packet with
real ACCMs!
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Ignored a SET LINK INFO packet with
real ACCMs!
Oct 4 23:24:32 spock pppd[2959]: LCP terminated by peer
(^VM-^@,M-2^@<M-Mt^@^@^BM-f)
Oct 4 23:24:32 spock pppd[2959]: LCP terminated by peer
(^VM-^@,M-2^@<M-Mt^@^@^BM-f)
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Error with select(), quitting
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Error with select(), quitting
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Client 209.136.33.71 control
connection finished
Oct 4 23:24:32 spock pptpd[2958]: CTRL: Client 209.136.33.71 control
connection finished
Oct 4 23:24:32 spock pppd[2959]: Modem hangup
Oct 4 23:24:32 spock pppd[2959]: Modem hangup
Oct 4 23:24:32 spock pppd[2959]: Connection terminated.
Oct 4 23:24:32 spock pppd[2959]: Connection terminated.
Oct 4 23:24:32 spock pppd[2959]: Connect time 0.1 minutes.
Oct 4 23:24:32 spock pppd[2959]: Connect time 0.1 minutes.
Oct 4 23:24:32 spock pppd[2959]: Sent 612 bytes, received 606 bytes.
Oct 4 23:24:32 spock pppd[2959]: Sent 612 bytes, received 606 bytes.
Oct 4 23:24:32 spock pppd[2959]: Exit.
Oct 4 23:24:32 spock pppd[2959]: Exit.
---------------------------------END---------------------------------------
Here is my /etc/ppp/options file:
--------------------------------BEGIN--------------------------------------
lock
auth
+chap
+chapms
+chapms-v2
mppe-40
mppe-128
mppe-stateless
proxyarp
require-chap
ipcp-accept-local
ipcp-accept-remote
lcp-echo-failure 20
lcp-echo-interval 5
---------------------------------END---------------------------------------
-------------------------------------------------------------------------
Steve Wood (Systems Programmer/Analyst) (505)647-0265
swood at collectrite.com http://www.collectrite.com Fax (505)523-1247
CRI Information Systems Las Cruces, NM USA
More information about the pptp-server
mailing list