Windows 7 connects to VPN, but then won't reconnect.
I have read a couple of articles on here about this situation, but have yet to find a solution.
Here's the problem:
I set up a L2TP VPN connection on Windows 7. It connects fine the first time. If you disconnect and try reconnecting, the Win 7 client will just sit there and not negotiate a connection and nothing ever shows up in the log on the Mac server. The Win 7 client will eventually time out with an error 789. Stopping and starting the VPN on the Mac server will reset everything and you can connect from the Win 7 machine again, but ONLY the one time. Eventually, the Mac server will time out and the Win 7 client will be allowed to connect again, but only the one time.
My logs:
I notice in the log that when a Mac client disconnects, it will show...
2012-02-14 14:49:59 EST Incoming call... Address given to client = 192.0.2.81
Tue Feb 14 14:49:59 2012 : Directory Services Authentication plugin initialized
Tue Feb 14 14:49:59 2012 : Directory Services Authorization plugin initialized
Tue Feb 14 14:49:59 2012 : L2TP incoming call in progress from 'xxx.xxx.xxx.xxx'...
Tue Feb 14 14:49:59 2012 : L2TP received SCCRQ
Tue Feb 14 14:49:59 2012 : L2TP sent SCCRP
Tue Feb 14 14:49:59 2012 : L2TP received SCCCN
Tue Feb 14 14:49:59 2012 : L2TP received ICRQ
Tue Feb 14 14:49:59 2012 : L2TP sent ICRP
Tue Feb 14 14:49:59 2012 : L2TP received ICCN
Tue Feb 14 14:49:59 2012 : L2TP connection established.
Tue Feb 14 14:49:59 2012 : using link 0
Tue Feb 14 14:49:59 2012 : Using interface ppp0
Tue Feb 14 14:49:59 2012 : Connect: ppp0 <--> socket[34:18]
Tue Feb 14 14:49:59 2012 : sent [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x40155730> <pcomp> <accomp>]
Tue Feb 14 14:49:59 2012 : rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x5083dcb2> <pcomp> <accomp>]
Tue Feb 14 14:49:59 2012 : lcp_reqci: returning CONFACK.
Tue Feb 14 14:49:59 2012 : sent [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x5083dcb2> <pcomp> <accomp>]
Tue Feb 14 14:49:59 2012 : rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x40155730> <pcomp> <accomp>]
Tue Feb 14 14:49:59 2012 : sent [LCP EchoReq id=0x0 magic=0x40155730]
Tue Feb 14 14:49:59 2012 : sent [CHAP Challenge id=0x52 <a4b0596fe344daba2d17894a9ee0ed5a>, name = "www.mydomain.com"]
Tue Feb 14 14:49:59 2012 : rcvd [LCP EchoReq id=0x0 magic=0x5083dcb2]
Tue Feb 14 14:49:59 2012 : sent [LCP EchoRep id=0x0 magic=0x40155730]
Tue Feb 14 14:49:59 2012 : rcvd [LCP EchoRep id=0x0 magic=0x5083dcb2]
Tue Feb 14 14:49:59 2012 : rcvd [CHAP Response id=0x52 <42de9ffd2a986fee935ebdebf7e08c9b000000000000000022b4eeec88db09e50cfb8f1a6c5cbf 39bb1ca0a120e11f9b00>, name = "Jimmy"]
Tue Feb 14 14:49:59 2012 : DSAuth plugin: Could not retrieve key agent account information.
Tue Feb 14 14:49:59 2012 : sent [CHAP Success id=0x52 "S=163744A264AC3237C6884E92C90BABAAC9F4BEB2 M=Access granted"]
Tue Feb 14 14:49:59 2012 : CHAP peer authentication succeeded for Jimmy
Tue Feb 14 14:49:59 2012 : DSAccessControl plugin: User 'Jimmy' authorized for access
Tue Feb 14 14:49:59 2012 : sent [IPCP ConfReq id=0x1 <addr xxx.xxx.xxx.xxx>]
Tue Feb 14 14:49:59 2012 : sent [ACSCP] 01 01 00 04
Tue Feb 14 14:49:59 2012 : rcvd [IPCP ConfReq id=0x1 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Tue Feb 14 14:49:59 2012 : ipcp: returning Configure-NAK
Tue Feb 14 14:49:59 2012 : sent [IPCP ConfNak id=0x1 <addr 192.0.2.81> <ms-dns1 192.0.2.2> <ms-dns3 192.0.2.3>]
Tue Feb 14 14:49:59 2012 : rcvd [IPV6CP ConfReq id=0x1 <addr fe80::6aa8:6dff:fe05:623c>]
Tue Feb 14 14:49:59 2012 : Unsupported protocol 0x8057 received
Tue Feb 14 14:49:59 2012 : sent [LCP ProtRej id=0x2 80 57 01 01 00 0e 01 0a 6a a8 6d ff fe 05 62 3c]
Tue Feb 14 14:49:59 2012 : rcvd [ACSCP] 01 01 00 10 01 06 00 00 00 01 02 06 00 00 00 01
Tue Feb 14 14:49:59 2012 : sent [ACSCP] 02 01 00 10 01 06 00 00 00 01 02 06 00 00 00 01
Tue Feb 14 14:49:59 2012 : rcvd [IPCP ConfAck id=0x1 <addr xxx.xxx.xxx.xxx>]
Tue Feb 14 14:49:59 2012 : rcvd [ACSCP] 02 01 00 04
Tue Feb 14 14:49:59 2012 : sent [ACSP data]
02 00 00 1b 00 0b 00 00 00 00 00 00 00 0d 74 68 '..............my'
65 2d 6d 6f 74 69 76 2e 63 6f 6d 'domain.com'
Tue Feb 14 14:49:59 2012 : sent [ACSP data]
01 00 00 14 00 0b 00 00 c0 00 02 00 ff ff ff 00 '................'
00 01 00 00 '....'
Tue Feb 14 14:49:59 2012 : rcvd [IPCP ConfReq id=0x2 <addr 192.0.2.81> <ms-dns1 192.0.2.2> <ms-dns3 192.0.2.3>]
Tue Feb 14 14:49:59 2012 : ipcp: returning Configure-ACK
Tue Feb 14 14:49:59 2012 : sent [IPCP ConfAck id=0x2 <addr 192.0.2.81> <ms-dns1 192.0.2.2> <ms-dns3 192.0.2.3>]
Tue Feb 14 14:49:59 2012 : ipcp: up
Tue Feb 14 14:49:59 2012 : found interface en0 for proxy arp
Tue Feb 14 14:49:59 2012 : local IP address xxx.xxx.xxx.xxx
Tue Feb 14 14:49:59 2012 : remote IP address 192.0.2.81
Tue Feb 14 14:49:59 2012 : rcvd [ACSP data]
02 00 00 08 00 04 00 00 '........'
Tue Feb 14 14:49:59 2012 : rcvd [ACSP data]
01 00 00 08 00 04 00 00 '........'
Tue Feb 14 14:50:46 2012 : rcvd [LCP TermReq id=0x2 "User request"]
Tue Feb 14 14:50:46 2012 : LCP terminated by peer (User request)
Tue Feb 14 14:50:46 2012 : ipcp: down
Tue Feb 14 14:50:46 2012 : sent [LCP TermAck id=0x2]
Tue Feb 14 14:50:46 2012 : L2TP received CDN
Tue Feb 14 14:50:46 2012 : Connection terminated.
Tue Feb 14 14:50:46 2012 : Connect time 0.8 minutes.
Tue Feb 14 14:50:46 2012 : Sent 270 bytes, received 522 bytes.
Tue Feb 14 14:50:46 2012 : L2TP disconnecting...
Tue Feb 14 14:50:46 2012 : L2TP disconnected
2012-02-14 14:50:46 EST --> Client with address = 192.0.2.81 has hungup
Everything looks normal there, BUT, when I connect via Windows 7, I get the following...
2012-02-14 14:49:09 EST Incoming call... Address given to client = 192.0.2.80
Tue Feb 14 14:49:09 2012 : Directory Services Authentication plugin initialized
Tue Feb 14 14:49:09 2012 : Directory Services Authorization plugin initialized
Tue Feb 14 14:49:09 2012 : L2TP incoming call in progress from 'xxx.xxx.xxx.xxx'...
Tue Feb 14 14:49:09 2012 : L2TP received SCCRQ
Tue Feb 14 14:49:09 2012 : L2TP sent SCCRP
Tue Feb 14 14:49:09 2012 : L2TP received SCCCN
Tue Feb 14 14:49:09 2012 : L2TP received ICRQ
Tue Feb 14 14:49:09 2012 : L2TP sent ICRP
Tue Feb 14 14:49:09 2012 : L2TP received ICCN
Tue Feb 14 14:49:09 2012 : L2TP connection established.
Tue Feb 14 14:49:09 2012 : using link 0
Tue Feb 14 14:49:09 2012 : Using interface ppp0
Tue Feb 14 14:49:09 2012 : Connect: ppp0 <--> socket[34:18]
Tue Feb 14 14:49:09 2012 : sent [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x4a60531e> <pcomp> <accomp>]
Tue Feb 14 14:49:09 2012 : rcvd [LCP ConfReq id=0x0 <mru 1400> <magic 0x49073983> <pcomp> <accomp>]
Tue Feb 14 14:49:09 2012 : lcp_reqci: returning CONFACK.
Tue Feb 14 14:49:09 2012 : sent [LCP ConfAck id=0x0 <mru 1400> <magic 0x49073983> <pcomp> <accomp>]
Tue Feb 14 14:49:09 2012 : rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <auth chap MS-v2> <magic 0x4a60531e> <pcomp> <accomp>]
Tue Feb 14 14:49:09 2012 : sent [LCP EchoReq id=0x0 magic=0x4a60531e]
Tue Feb 14 14:49:09 2012 : sent [CHAP Challenge id=0xb5 <9cedcb72c98dfb0405569a25c3e5874a>, name = "www.mydomain.com"]
Tue Feb 14 14:49:09 2012 : rcvd [LCP EchoRep id=0x0 magic=0x49073983]
Tue Feb 14 14:49:09 2012 : rcvd [CHAP Response id=0xb5 <3830c59ed501163336cb7ce4d4a2f9a4000000000000000043851df834e436aa5577f6fe2d1595 8409a9b5118b72ea7800>, name = "Jimmy"]
Tue Feb 14 14:49:09 2012 : DSAuth plugin: Could not retrieve key agent account information.
Tue Feb 14 14:49:09 2012 : sent [CHAP Success id=0xb5 "S=D0D0E6A0A6990521AA522DF916E821266CBA2052 M=Access granted"]
Tue Feb 14 14:49:09 2012 : CHAP peer authentication succeeded for Jimmy
Tue Feb 14 14:49:09 2012 : DSAccessControl plugin: User 'Jimmy' authorized for access
Tue Feb 14 14:49:09 2012 : sent [IPCP ConfReq id=0x1 <addr xxx.xxx.xxx.xxx>]
Tue Feb 14 14:49:09 2012 : sent [ACSCP] 01 01 00 04
Tue Feb 14 14:49:09 2012 : rcvd [IPV6CP ConfReq id=0x1 <addr fe80::cc29:74a9:d54b:5a1e>]
Tue Feb 14 14:49:09 2012 : Unsupported protocol 0x8057 received
Tue Feb 14 14:49:09 2012 : sent [LCP ProtRej id=0x2 80 57 01 01 00 0e 01 0a cc 29 74 a9 d5 4b 5a 1e]
Tue Feb 14 14:49:09 2012 : rcvd [CCP ConfReq id=0x2 <mppe +H -M -S -L -D -C>]
Tue Feb 14 14:49:09 2012 : Unsupported protocol 'Compression Control Protocol' (0x80fd) received
Tue Feb 14 14:49:09 2012 : sent [LCP ProtRej id=0x3 80 fd 01 02 00 0a 12 06 01 00 00 00]
Tue Feb 14 14:49:09 2012 : rcvd [LCP ProtRej id=0x4 82 35 01 01 00 04]
Tue Feb 14 14:49:09 2012 : rcvd [IPCP ConfReq id=0x3 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-wins1 0.0.0.0> <ms-dns3 0.0.0.0> <ms-wins3 0.0.0.0>]
Tue Feb 14 14:49:09 2012 : ipcp: returning Configure-REJ
Tue Feb 14 14:49:09 2012 : sent [IPCP ConfRej id=0x3 <ms-wins1 0.0.0.0> <ms-wins3 0.0.0.0>]
Tue Feb 14 14:49:09 2012 : rcvd [IPCP ConfAck id=0x1 <addr xxx.xxx.xxx.xxx>]
Tue Feb 14 14:49:09 2012 : rcvd [IPCP ConfReq id=0x5 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Tue Feb 14 14:49:09 2012 : ipcp: returning Configure-NAK
Tue Feb 14 14:49:09 2012 : sent [IPCP ConfNak id=0x5 <addr 192.0.2.80> <ms-dns1 192.0.2.2> <ms-dns3 192.0.2.3>]
Tue Feb 14 14:49:09 2012 : rcvd [IPCP ConfReq id=0x6 <addr 192.0.2.80> <ms-dns1 192.0.2.2> <ms-dns3 192.0.2.3>]
Tue Feb 14 14:49:09 2012 : ipcp: returning Configure-ACK
Tue Feb 14 14:49:09 2012 : sent [IPCP ConfAck id=0x6 <addr 192.0.2.80> <ms-dns1 192.0.2.2> <ms-dns3 192.0.2.3>]
Tue Feb 14 14:49:09 2012 : ipcp: up
Tue Feb 14 14:49:09 2012 : found interface en0 for proxy arp
Tue Feb 14 14:49:09 2012 : local IP address xxx.xxx.xxx.xxx
Tue Feb 14 14:49:09 2012 : remote IP address 192.0.2.80
Tue Feb 14 14:49:09 2012 : rcvd [IP data <src addr 192.0.2.80> <dst addr 255.255.255.255> <BOOTP Request> <type INFORM> <client id 0x006f6ba875fe7a4a4e9728ea65d26aae97> <host name "Win-7"> <vendor class id "MSFT 5.0"> <parameters = 0x6 0x2c 0x2b 0x1 0xf9 0xf>]
Tue Feb 14 14:49:09 2012 : sent [IP data <src addr xxx.xxx.xxx.xxx> <dst addr 192.0.2.80> <BOOTP Reply> <type ACK> <server id 0x4658faca> <domain name "mydomain.com"> <static routes 192.0.2.0/255.255.255.0/192.0.2.80>]
Tue Feb 14 14:49:31 2012 : rcvd [LCP TermReq id=0x7 "I\0079\37777777603\000<\37777777715t\000\000\000\000"]
Tue Feb 14 14:49:31 2012 : LCP terminated by peer (I^G9M-^C^@<M-Mt^@^@^@^@)
Tue Feb 14 14:49:31 2012 : ipcp: down
Tue Feb 14 14:49:31 2012 : sent [LCP TermAck id=0x7]
Tue Feb 14 14:49:31 2012 : L2TP received CDN
Tue Feb 14 14:49:31 2012 : Connection terminated.
Tue Feb 14 14:49:31 2012 : Connect time 0.4 minutes.
Tue Feb 14 14:49:31 2012 : Sent 1756 bytes, received 4585 bytes.
Tue Feb 14 14:49:31 2012 : L2TP disconnecting...
Tue Feb 14 14:49:31 2012 : L2TP disconnected
2012-02-14 14:49:31 EST --> Client with address = 192.0.2.80 has hungup
I'm wondering if the LCP Termination Request is not being sent from the Windows machine correctly and the Mac server does not know how to handle it, so it freezes the process for a while until it resets itself or the VPN process is reset by stopping and restarting it.
Any and all help would be greatly appreciated.