[pptp-server] Please help! Failed select() in VPN pptpd

Sun Oct 1 22:15:42 CDT 2000

Hello

Sorry for the length of this post but I've been beating my head againist the wall trying to get a Win98SE VPN client to connect to a Linux firewall server. I've built the 2.2.17 kernel with the pptp masq patch and the ppp/mppe encryption patches in the kernel and the pppd.  I'm running the prebuilt PoPToP 1.0.0 binary RPM. I've set all the firewall rules wide open, and connections fail coming in from the Internet or the local net with the same error.  Everything builds fine, and seems to connect but the connection fails with a error in the pptpd.log file of "Sep 24 22:39:11 boo pptpd[952]: CTRL: Error with select(), quitting".

I've searched the the HOW-TO's, archives and  seen other pptpd logs with this same error in the select() function. What does it imply? Could Matthew Ramsay or somebody explain what is going on?  I'm stumped, any help would be appreciated.

I've included the important parts of the Linux log and config files as well as the Win98SE VPN log file.  Thanks in advance.

Eric Van Duser
evanduser at pacbell.net

--options file---
lock
debug
# ms-wins 192.158.1.253
auth
+chap
+chapms
+chapms-v2
mppe-40
mppe-128
mppe-stateless
proxyarp
# require-chap
name boo
# netmask 255.255.255.0
# mru 1400
# mtu 1400
# ktune

---chap-secrets file---
# Secrets for authentication using CHAP
# client        server  secret                  IP addresses
GORDIAN\\eric   boo     password  *

---pptpd.conf---

################################################################################
#
# Sample PoPToP configuration file
#
# for PoPToP version 1.0.0
#
################################################################################

speed 115200
option /etc/ppp/options
debug
localip 192.168.1.110-119
remoteip 192.168.1.120-129
pidfile /var/run/pptpd.pid

--- /var/log/messages--
Sep 24 22:38:46 boo pppd[953]: pppd 2.3.11 started by root, uid 0
Sep 24 22:38:46 boo pppd[953]: Using interface ppp0
Sep 24 22:38:46 boo pppd[953]: Connect: ppp0 <--> /dev/pts/1
Sep 24 22:39:11 boo pppd[953]: Modem hangup
Sep 24 22:39:11 boo pppd[953]: Connection terminated.
Sep 24 22:39:11 boo pppd[953]: Exit.

--- /var/log/pptpd.log---
Sep 24 22:38:46 boo pptpd[952]: MGR: Launching /usr/sbin/pptpctrl to handle client
Sep 24 22:38:46 boo pptpd[952]: CTRL: local address = 192.168.1.111
Sep 24 22:38:46 boo pptpd[952]: CTRL: remote address = 192.168.1.121
Sep 24 22:38:46 boo pptpd[952]: CTRL: pppd speed = 115200
Sep 24 22:38:46 boo pptpd[952]: CTRL: pppd options file = /etc/ppp/options
Sep 24 22:38:46 boo pptpd[952]: CTRL: Client 216.102.153.20 control connection started
Sep 24 22:38:46 boo pptpd[952]: CTRL: Received PPTP Control Message (type: 1)
Sep 24 22:38:46 boo pptpd[952]: CTRL: Made a START CTRL CONN RPLY packet
Sep 24 22:38:46 boo pptpd[952]: CTRL: I wrote 156 bytes to the client.
Sep 24 22:38:46 boo pptpd[952]: CTRL: Sent packet to client
Sep 24 22:38:46 boo pptpd[952]: CTRL: Received PPTP Control Message (type: 7)
Sep 24 22:38:46 boo pptpd[952]: CTRL: Set parameters to 0 maxbps, 16 window size
Sep 24 22:38:46 boo pptpd[952]: CTRL: Made a OUT CALL RPLY packet
Sep 24 22:38:46 boo pptpd[952]: CTRL: Starting call (launching pppd, opening GRE)
Sep 24 22:38:46 boo pptpd[952]: CTRL: pty_fd = 5
Sep 24 22:38:46 boo pptpd[952]: CTRL: tty_fd = 6
Sep 24 22:38:46 boo pptpd[953]: CTRL (PPPD Launcher): Connection speed = 115200
Sep 24 22:38:46 boo pptpd[953]: CTRL (PPPD Launcher): local address = 192.168.1.111
Sep 24 22:38:46 boo pptpd[953]: CTRL (PPPD Launcher): remote address = 192.168.1.121
Sep 24 22:38:46 boo pptpd[952]: CTRL: I wrote 32 bytes to the client.
Sep 24 22:38:46 boo pptpd[952]: CTRL: Sent packet to client
Sep 24 22:39:11 boo pptpd[952]: CTRL: Received PPTP Control Message (type: 12)
Sep 24 22:39:11 boo pptpd[952]: CTRL: Made a CALL DISCONNECT RPLY packet
Sep 24 22:39:11 boo pptpd[952]: CTRL: Received CALL CLR request (closing call)
Sep 24 22:39:11 boo pptpd[952]: CTRL: I wrote 148 bytes to the client.
Sep 24 22:39:11 boo pptpd[952]: CTRL: Sent packet to client
Sep 24 22:39:11 boo pptpd[952]: CTRL: Error with select(), quitting
Sep 24 22:39:11 boo pptpd[952]: CTRL: Client 216.102.153.20 control connection finished
Sep 24 22:39:11 boo pptpd[952]: CTRL: Exiting now
Sep 24 22:39:11 boo pptpd[874]: MGR: Reaped child 952

--- Client side Win98SE log---
09-24-2000 23:06:53.82 - Microsoft Dial Up Adapter log opened.
09-24-2000 23:06:53.82 - Server type is  PPP (Point to Point Protocol).
09-24-2000 23:06:53.82 - FSA : Adding Control Protocol 80fd (CCP) to control protocol chain.
09-24-2000 23:06:53.82 - FSA : Protocol not bound - skipping control protocol 803f (NBFCP).
09-24-2000 23:06:53.82 - FSA : Adding Control Protocol 8021 (IPCP) to control protocol chain.
09-24-2000 23:06:53.82 - FSA : Protocol disabled by user - skipping control protocol 802b (IPXCP).
09-24-2000 23:06:53.82 - FSA : Adding Control Protocol c029 (CallbackCP) to control protocol chain.
09-24-2000 23:06:53.82 - FSA : Encrypted Password required.
09-24-2000 23:06:53.82 - FSA : Encrypted Password required.
09-24-2000 23:06:53.82 - FSA : Adding Control Protocol c223 (CHAP) to control protocol chain.
09-24-2000 23:06:53.82 - FSA : Adding Control Protocol c021 (LCP) to control protocol chain.
09-24-2000 23:06:53.82 - LCP : Layer started.
09-24-2000 23:06:53.82 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:06:53.82 - Data 0000: c0 21 01 01 00 0e 05 06 | .!......
09-24-2000 23:06:53.82 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:06:54.07 - PPP : Received Control Packet of length: 27
09-24-2000 23:06:54.07 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:06:54.07 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:06:54.07 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:06:54.07 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:06:54.07 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:06:54.07 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:06:54.07 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:06:54.07 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:06:54.07 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:06:54.07 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:06:54.07 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:06:54.07 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:06:54.07 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:06:54.07 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:06:56.82 - PPP : Received Control Packet of length: 27
09-24-2000 23:06:56.82 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:06:56.82 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:06:56.82 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:06:56.82 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:06:56.82 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:06:56.82 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:06:56.82 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:06:56.82 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:06:56.82 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:06:56.82 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:06:56.82 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:06:56.82 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:06:56.82 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:06:56.82 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:06:57.33 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:06:57.33 - Data 0000: c0 21 01 02 00 0e 05 06 | .!......
09-24-2000 23:06:57.33 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:06:59.83 - PPP : Received Control Packet of length: 27
09-24-2000 23:06:59.83 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:06:59.83 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:06:59.83 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:06:59.83 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:06:59.83 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:06:59.83 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:06:59.83 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:06:59.83 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:06:59.83 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:06:59.83 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:06:59.83 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:06:59.83 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:06:59.83 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:06:59.83 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:00.33 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:07:00.33 - Data 0000: c0 21 01 03 00 0e 05 06 | .!......
09-24-2000 23:07:00.33 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:07:02.84 - PPP : Received Control Packet of length: 27
09-24-2000 23:07:02.84 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:07:02.84 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:02.84 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:02.84 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:02.84 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:07:02.84 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:07:02.84 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:07:02.84 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:07:02.84 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:07:02.84 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:07:02.84 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:07:02.84 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:02.84 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:02.84 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:03.33 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:07:03.33 - Data 0000: c0 21 01 04 00 0e 05 06 | .!......
09-24-2000 23:07:03.33 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:07:05.85 - PPP : Received Control Packet of length: 27
09-24-2000 23:07:05.85 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:07:05.85 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:05.85 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:05.85 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:05.85 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:07:05.85 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:07:05.85 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:07:05.85 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:07:05.85 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:07:05.85 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:07:05.85 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:07:05.85 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:05.85 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:05.85 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:06.33 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:07:06.33 - Data 0000: c0 21 01 05 00 0e 05 06 | .!......
09-24-2000 23:07:06.33 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:07:08.87 - PPP : Received Control Packet of length: 27
09-24-2000 23:07:08.87 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:07:08.87 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:08.87 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:08.87 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:08.87 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:07:08.87 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:07:08.87 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:07:08.87 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:07:08.87 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:07:08.87 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:07:08.87 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:07:08.87 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:08.87 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:08.87 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:09.33 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:07:09.33 - Data 0000: c0 21 01 06 00 0e 05 06 | .!......
09-24-2000 23:07:09.33 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:07:11.88 - PPP : Received Control Packet of length: 27
09-24-2000 23:07:11.88 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:07:11.88 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:11.88 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:11.88 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:11.88 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:07:11.88 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:07:11.88 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:07:11.88 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:07:11.88 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:07:11.88 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:07:11.88 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:07:11.88 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:11.88 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:11.88 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:12.33 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:07:12.33 - Data 0000: c0 21 01 07 00 0e 05 06 | .!......
09-24-2000 23:07:12.33 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:07:14.89 - PPP : Received Control Packet of length: 27
09-24-2000 23:07:14.89 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:07:14.89 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:14.89 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:14.89 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:14.89 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:07:14.89 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:07:14.89 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:07:14.89 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:07:14.89 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:07:14.89 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:07:14.89 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:07:14.89 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:14.89 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:14.89 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:15.33 - PPP : Transmitting Control Packet of length: 16
09-24-2000 23:07:15.33 - Data 0000: c0 21 01 08 00 0e 05 06 | .!......
09-24-2000 23:07:15.33 - Data 0008: 02 cc dd b1 07 02 08 02 | ........
09-24-2000 23:07:17.90 - PPP : Received Control Packet of length: 27
09-24-2000 23:07:17.90 - Data 0000: c0 21 01 01 00 19 02 06 | .!.....
09-24-2000 23:07:17.90 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:17.90 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:17.90 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:17.90 - LCP : Received and accepted ACCM of 0.
09-24-2000 23:07:17.90 - LCP : Received and accepted authentication protocol c223 (CHAP).
09-24-2000 23:07:17.90 - LCP : Received and accepted magic number 1507360e.
09-24-2000 23:07:17.90 - LCP : Received and accepted protocol field compression option.
09-24-2000 23:07:17.90 - LCP : Received and accepted address+control field compression option.
09-24-2000 23:07:17.90 - PPP : Transmitting Control Packet of length: 27
09-24-2000 23:07:17.90 - Data 0000: c0 21 02 01 00 19 02 06 | .!.....
09-24-2000 23:07:17.90 - Data 0008: 00 00 00 00 03 05 c2 23 | .......#
09-24-2000 23:07:17.90 - Data 0010: 81 05 06 15 07 36 0e 07 | ....6..
09-24-2000 23:07:17.90 - Data 0018: 02 08 02 00 00 00 00 00 | ........
09-24-2000 23:07:18.83 - LCP : Layer finished.
09-24-2000 23:07:18.84 - Remote access driver is shutting down.
09-24-2000 23:07:18.84 - CRC Errors             0
09-24-2000 23:07:18.84 - Timeout Errors         0
09-24-2000 23:07:18.84 - Alignment Errors       0
09-24-2000 23:07:18.84 - Overrun Errors         0
09-24-2000 23:07:18.84 - Framing Errors         0
09-24-2000 23:07:18.84 - Buffer Overrun Errors  0
09-24-2000 23:07:18.84 - Incomplete Packets     0
09-24-2000 23:07:18.84 - Bytes Received         261
09-24-2000 23:07:18.84 - Bytes Transmittted     376
09-24-2000 23:07:18.84 - Frames Received        9
09-24-2000 23:07:18.84 - Frames Transmitted     16
09-24-2000 23:07:18.84 - LCP : Layer started.
09-24-2000 23:07:18.84 - Microsoft Dial Up Adapter log closed.

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.schulte.org/mailman/private/pptp-server/attachments/20001001/4ef82d37/attachment.html>