[pptp-server] pptp server, auth ok, fails to start Windows ERR: 742

Tue Oct 17 04:21:52 CDT 2000

Hi,
(Sorry for the long message)
    I set up the pptp server following the 'RedHat-PoPToP HOWTO', except I
used ppp 2.3.11 and SSLeay 0.9 and kernel 2.2.17 (source not rpm). After
making appropriate patches and fixing the rejects (the patch is meant for an
earlier version of ppp 2.3.10 I think) and fixing some other minor problems
(changing a typo in a patch.... it had stpcpy instead of strcpy, added
PPP_VERSION etc), I can get to the Windows ME client to authenticate
properly:

(linux log)
Oct 17 18:51:47 gateway pptpd[3997]: MGR: Launching /usr/local/sbin/pptpctrl
to handle client
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: local address = 192.168.1.1
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: remote address = 192.168.1.3
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: pppd speed = 115200
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: pppd options file =
/etc/ppp/options
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Client 192.168.32.10 control
connection started
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Received PPTP Control Message
(type: 1)
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Made a START CTRL CONN RPLY
packet
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: I wrote 156 bytes to the client.
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Sent packet to client
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Received PPTP Control Message
(type: 7)
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Set parameters to 1525 maxbps, 64
window size
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Made a OUT CALL RPLY packet
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Starting call (launching pppd,
opening GRE)
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: pty_fd = 5
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: tty_fd = 6
Oct 17 18:51:47 gateway pptpd[3998]: CTRL (PPPD Launcher): Connection speed
= 115200
Oct 17 18:51:47 gateway pptpd[3998]: CTRL (PPPD Launcher): local address =
192.168.1.1
Oct 17 18:51:47 gateway pptpd[3998]: CTRL (PPPD Launcher): remote address =
192.168.1.3
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: I wrote 32 bytes to the client.
Oct 17 18:51:47 gateway pptpd[3997]: CTRL: Sent packet to client
Oct 17 18:51:47 gateway kernel: CSLIP: code copyright 1989 Regents of the
University of California
Oct 17 18:51:47 gateway kernel: PPP: version 2.3.11 (demand dialling)
Oct 17 18:51:47 gateway kernel: PPP line discipline registered.
Oct 17 18:51:47 gateway kernel: registered device ppp0
Oct 17 18:51:47 gateway pppd[3998]: pppd 2.3.11 started by root, uid 0
Oct 17 18:51:47 gateway pppd[3998]: Using interface ppp0
Oct 17 18:51:47 gateway pppd[3998]: Connect: ppp0 <--> /dev/pts/1
Oct 17 18:51:47 gateway pptpd[3997]: GRE: Discarding duplicate packet
Oct 17 18:51:50 gateway kernel: PPP BSD Compression module registered
Oct 17 18:51:50 gateway kernel: PPP MPPE compression module registered
Oct 17 18:51:50 gateway kernel: PPP Deflate Compression module registered
Oct 17 18:51:50 gateway pppd[3998]: MSCHAP-v2 peer authentication succeeded
for cybertrash\\vpn_user
Oct 17 18:51:50 gateway pppd[3998]: LCP terminated by peer
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: Received PPTP Control Message
(type: 12)
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: Made a CALL DISCONNECT RPLY
packet
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: Received CALL CLR request
(closing call)
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: I wrote 148 bytes to the client.
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: Sent packet to client
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: Error with select(), quitting
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: Client 192.168.32.10 control
connection finished
Oct 17 18:51:50 gateway pptpd[3997]: CTRL: Exiting now
Oct 17 18:51:50 gateway pptpd[3336]: MGR: Reaped child 3997
Oct 17 18:51:50 gateway pppd[3998]: Modem hangup
Oct 17 18:51:50 gateway pppd[3998]: Connection terminated.
Oct 17 18:51:50 gateway pppd[3998]: Connect time 0.1 minutes.
Oct 17 18:51:50 gateway pppd[3998]: Sent 263 bytes, received 207 bytes.
Oct 17 18:51:50 gateway pppd[3998]: Exit.

So this all looks good. (I think? anyone?). I think the problem is here:
(Windows Log)
10-16-2000 21:51:01.66 - 192.168.32.2:Attempting to connect to remote
computer via TCP/IP
10-16-2000 21:51:01.66 - 192.168.32.2:Control channel TCP/IP port
successfully connected
10-16-2000 21:51:01.66 - 192.168.32.2:Starting PPTP control channel setup
10-16-2000 21:51:01.66 - 192.168.32.2:Sending CONTROL_START_REQUEST
10-16-2000 21:51:01.68 - 192.168.32.2:CTL CONTROL_START_REPLY RECEIVED
10-16-2000 21:51:01.68 - 192.168.32.2:Control Channel Successfully
Established
10-16-2000 21:51:01.68 - 192.168.32.2:Sending CALL_OUT_REQUEST
10-16-2000 21:51:01.72 - 192.168.32.2:CALL_OUT_REPLY RECEIVED
10-16-2000 21:51:01.72 - 192.168.32.2:Call Successfully Established
******* Somewhere here *********************************
10-16-2000 21:51:01.82 - 192.168.32.2:Sending CALL_CLEAR_REQUEST
10-16-2000 21:51:01.82 - 192.168.32.2:CALL_DISCONNECT_NOTIFY RECEIVED
10-16-2000 21:51:01.82 - 192.168.32.2:Sending CONTROL_STOP_REQUEST
*******************************************************************
10-16-2000 21:51:01.86 - 192.168.32.2:TCP disconnected
10-16-2000 21:51:01.86 - 192.168.32.2:TCP disconnecting

Can anyone tell me what CALL_DISCONNECT_NOTIFY RECEIVED actually means? and
why it happens?
NOTE: This is purely internal (at this stage), although eventually I will
use it live.... providing I can get it working! :)

I'm pretty sure this is fine, but I'll include it anyway!
This is the Windows PPP log (selected bits anyway):
10-16-2000 22:51:02.77 - CHAP : Login was successful.
10-16-2000 22:51:02.77 - PPP : Received Control Packet of length: 18
10-16-2000 22:51:02.77 - Data 0000: 80 21 01 01 00 10 03 06 | .!......
10-16-2000 22:51:02.77 - Data 0008: c0 a8 01 01 02 06 00 2d | .......-
10-16-2000 22:51:02.77 - Data 0010: 0f 01 00 00 00 00 00 00 | ........
10-16-2000 22:51:02.77 - PPP : Received Control Packet of length: 23
10-16-2000 22:51:02.77 - Data 0000: 80 fd 01 01 00 15 1a 04 | ......
10-16-2000 22:51:02.77 - Data 0008: 78 00 18 04 78 00 12 06 | x..x...
10-16-2000 22:51:02.77 - Data 0010: 01 00 00 20 15 03 2f 00 | ... ./.
10-16-2000 22:51:03.91 - Remote access driver is shutting down.
10-16-2000 22:51:03.91 - CRC Errors             0
10-16-2000 22:51:03.91 - Timeout Errors         0
10-16-2000 22:51:03.91 - Alignment Errors       0
10-16-2000 22:51:03.91 - Overrun Errors         0
10-16-2000 22:51:03.91 - Framing Errors         0
10-16-2000 22:51:03.91 - Buffer Overrun Errors  0
10-16-2000 22:51:03.91 - Incomplete Packets     0
10-16-2000 22:51:03.91 - Bytes Received         167
10-16-2000 22:51:03.91 - Bytes Transmittted     140
10-16-2000 22:51:03.91 - Frames Received        6
10-16-2000 22:51:03.91 - Frames Transmitted     4
10-16-2000 22:51:03.91 - LCP : Layer down.

    Thanks,

        Nick Blievers