[pptp-server] pppd LCP timeout

Tue Mar 14 19:28:39 CST 2000

I am on a small home network with a firewall and I am trying to connect to
my VPN at work. the server at work is running redhat6.1 with updates and a
variant on the ipchains-firewall script. I have set up pptp on the server
and can verify it is functional from within the network (i.e. I can
establish a connection. with password/data encryption) but I am unable to
connect from home. my windows client times out while verifying user/pass.
I have tried disabling all encryption requirements and I still have the same
trouble.

pasted below are my server and client logs.

any suggestions? I am going to get the pptp-traceroute.patch next and see if
I can find out more. I am most grateful
for any help.

---server debug log---
Mar 14 14:46:27 test pptpd[1597]: MGR: Launching /usr/sbin/pptpctrl to
handle client
Mar 14 14:46:27 test pptpd[1597]: CTRL: local address = 192.168.0.200
Mar 14 14:46:27 test pptpd[1597]: CTRL: remote address = 192.168.1.2
Mar 14 14:46:27 test pptpd[1597]: CTRL: Client 206.225.63.176 control
connection started
Mar 14 14:46:27 test pptpd[1597]: CTRL: Received PPTP Control Message (type:
1)
Mar 14 14:46:27 test pptpd[1597]: CTRL: Made a START CTRL CONN RPLY packet
Mar 14 14:46:27 test pptpd[1597]: CTRL: I wrote 156 bytes to the client.
Mar 14 14:46:27 test pptpd[1597]: CTRL: Sent packet to client
Mar 14 14:46:27 test pptpd[1597]: CTRL: Received PPTP Control Message (type:
7)
Mar 14 14:46:27 test pptpd[1597]: CTRL: Set parameters to 0 maxbps, 16
window size
Mar 14 14:46:27 test pptpd[1597]: CTRL: Made a OUT CALL RPLY packet
Mar 14 14:46:27 test pptpd[1597]: CTRL: Starting call (launching pppd,
opening GRE)
Mar 14 14:46:27 test pptpd[1597]: CTRL: pty_fd = 5
Mar 14 14:46:27 test pptpd[1597]: CTRL: tty_fd = 6
Mar 14 14:46:27 test pptpd[1598]: CTRL (PPPD Launcher): Connection speed =
115200
Mar 14 14:46:27 test pptpd[1597]: CTRL: I wrote 32 bytes to the client.
Mar 14 14:46:27 test pptpd[1597]: CTRL: Sent packet to client
Mar 14 14:46:27 test pptpd[1598]: CTRL (PPPD Launcher): local address =
192.168.0.200
Mar 14 14:46:27 test pptpd[1598]: CTRL (PPPD Launcher): remote address =
192.168.1.2
Mar 14 14:46:27 test pppd[1598]: pppd 2.3.10 started by root, uid 0
Mar 14 14:46:27 test pppd[1598]: Using interface ppp0
Mar 14 14:46:27 test pppd[1598]: Connect: ppp0 <--> /dev/pts/0
Mar 14 14:46:27 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:27 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:30 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:30 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:33 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:33 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:36 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:36 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:39 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:39 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:42 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:42 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:45 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:45 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:48 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:48 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:51 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:51 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:54 test pppd[1598]: sent [LCP ConfReq id=0x1 <asyncmap 0x0>
<auth chap 81> <magic 0x19ca90f6> <pcomp> <accomp>]
Mar 14 14:46:54 test pppd[1598]: Timeout 0x8050164:0x8077660 in 3 seconds.
Mar 14 14:46:57 test pptpd[1597]: CTRL: Received PPTP Control Message (type:
12)
Mar 14 14:46:57 test pptpd[1597]: CTRL: Made a CALL DISCONNECT RPLY packet
Mar 14 14:46:57 test pptpd[1597]: CTRL: Received CALL CLR request (closing
call)
Mar 14 14:46:57 test pptpd[1597]: CTRL: I wrote 148 bytes to the client.
Mar 14 14:46:57 test pptpd[1597]: CTRL: Sent packet to client
Mar 14 14:46:57 test pptpd[1597]: CTRL: Error with select(), quitting
Mar 14 14:46:57 test pptpd[1597]: CTRL: Client 206.225.63.176 control
connection finished
Mar 14 14:46:57 test pptpd[1597]: CTRL: Exiting now
Mar 14 14:46:57 test pptpd[629]: MGR: Reaped child 1597
Mar 14 14:46:57 test pppd[1598]: Modem hangup
Mar 14 14:46:57 test pppd[1598]: Untimeout 0x8050164:0x8077660.
Mar 14 14:46:57 test pppd[1598]: Connection terminated.
Mar 14 14:46:57 test pppd[1598]: Exit.

---win98 client---
01-03-1980 21:19:40.22 - Microsoft Dial Up Adapter log opened.
01-03-1980 21:19:40.22 - Server type is  PPP (Point to Point Protocol).
01-03-1980 21:19:40.22 - FSA : Adding Control Protocol 80fd (CCP) to control
protocol chain.
01-03-1980 21:19:40.22 - FSA : Protocol not bound - skipping control
protocol 803f (NBFCP).
01-03-1980 21:19:40.22 - FSA : Adding Control Protocol 8021 (IPCP) to
control protocol chain.
01-03-1980 21:19:40.22 - FSA : Protocol not bound - skipping control
protocol 802b (IPXCP).
01-03-1980 21:19:40.22 - FSA : Adding Control Protocol c029 (CallbackCP) to
control protocol chain.
01-03-1980 21:19:40.22 - FSA : Encrypted Password required.
01-03-1980 21:19:40.22 - FSA : Encrypted Password required.
01-03-1980 21:19:40.22 - FSA : Adding Control Protocol c223 (CHAP) to
control protocol chain.
01-03-1980 21:19:40.22 - FSA : Adding Control Protocol c021 (LCP) to control
protocol chain.
01-03-1980 21:19:40.22 - LCP : Layer started.
01-03-1980 21:19:40.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:19:40.22 - Data 0000: c0 21 01 01 00 0e 05 06 | .!......
01-03-1980 21:19:40.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:19:43.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:19:43.22 - Data 0000: c0 21 01 02 00 0e 05 06 | .!......
01-03-1980 21:19:43.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:19:46.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:19:46.22 - Data 0000: c0 21 01 03 00 0e 05 06 | .!......
01-03-1980 21:19:46.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:19:49.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:19:49.22 - Data 0000: c0 21 01 04 00 0e 05 06 | .!......
01-03-1980 21:19:49.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:19:52.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:19:52.22 - Data 0000: c0 21 01 05 00 0e 05 06 | .!......
01-03-1980 21:19:52.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:19:55.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:19:55.22 - Data 0000: c0 21 01 06 00 0e 05 06 | .!......
01-03-1980 21:19:55.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:19:58.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:19:58.22 - Data 0000: c0 21 01 07 00 0e 05 06 | .!......
01-03-1980 21:19:58.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:20:01.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:20:01.22 - Data 0000: c0 21 01 08 00 0e 05 06 | .!......
01-03-1980 21:20:01.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:20:04.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:20:04.22 - Data 0000: c0 21 01 09 00 0e 05 06 | .!......
01-03-1980 21:20:04.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:20:07.22 - PPP : Transmitting Control Packet of length: 16
01-03-1980 21:20:07.22 - Data 0000: c0 21 01 0a 00 0e 05 06 | .!......
01-03-1980 21:20:07.22 - Data 0008: 04 96 e4 7d 07 02 08 02 | ...}....
01-03-1980 21:20:10.22 - LCP : Layer finished.
01-03-1980 21:20:10.24 - Remote access driver is shutting down.
01-03-1980 21:20:10.24 - CRC Errors             0
01-03-1980 21:20:10.24 - Timeout Errors         0
01-03-1980 21:20:10.24 - Alignment Errors       0
01-03-1980 21:20:10.24 - Overrun Errors         0
01-03-1980 21:20:10.24 - Framing Errors         0
01-03-1980 21:20:10.24 - Buffer Overrun Errors  0
01-03-1980 21:20:10.24 - Incomplete Packets     0
01-03-1980 21:20:10.24 - Bytes Received         0
01-03-1980 21:20:10.24 - Bytes Transmittted     180
01-03-1980 21:20:10.24 - Frames Received        0
01-03-1980 21:20:10.24 - Frames Transmitted     10
01-03-1980 21:20:10.24 - LCP : Layer started.
01-03-1980 21:20:10.24 - Microsoft Dial Up Adapter log closed.