Thread Info
  • State Not Answered
  • Locked Locked
  • Replies 14 replies
  • Subscribers 1 subscriber
  • Views 2903 views
  • Users 0 members are here
Options
Suggested
This discussion has been locked.
You can no longer post new replies to this discussion. If you have a question you can start a new discussion

PPTP VPN Connections require two attempts?

JeremySherriff
Hi all

I thought this might have been resolved or discussed before but I can't find any mention of it.

Inbound PPTP VPNs to Astaro's behind a NAT device (v5, v5.2, v6, v6.3) often require two attempts to conenct from WinXP machines (and I assume other OS's too but have not tested).

The first attempt hangs at "verifying username and password", times out, and the next attempt to connect is immediately connected fine.

As luck would have it none of my Astaro's are doing this right now but I will post PPTP logs as soon as I can.

Has anyone else seen this issue?  i suspect the fix is at the cleint end but I have not found a combination that works yet.

TIA


This thread was automatically locked due to age.
Parents
  • 0
    Some logs to look at.

    A failed connection:
    2006:07:29-10:00:22 (none) pptpd[22692]: CTRL: Client 222.152.11.159 control connection started
    2006:07:29-10:00:22 (none) pptpd[22692]: CTRL: Starting call (launching pppd, opening GRE)
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: Plugin /usr/sbin/aua.so loaded.
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: AUA plugin initialized.
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: Plugin /usr/sbin/aua.so loaded.
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: AUA plugin initialized.
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: pppd 2.4.3 started by (unknown), uid 0
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: Starting negotiation on /dev/ttyp0
    2006:07:29-10:00:23 (none) pptpd[22692]: GRE: Bad checksum from pppd.
    2006:07:29-10:00:23 (none) pptpd[22692]: GRE: xmit failed from decaps_hdlc: Operation not permitted
    2006:07:29-10:00:23 (none) pptpd[22692]: CTRL: PTY read or GRE write failed (pty,gre)=(4,5)
    2006:07:29-10:00:23 (none) pptpd[22692]: CTRL: Reaping child PPP[22693]
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: Modem hangup
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: Connection terminated.
    2006:07:29-10:00:23 (none) pppd-pptp[22693]: Exit.
    2006:07:29-10:00:23 (none) pptpd[22692]: CTRL: Client 222.152.11.159 control connection finished

    A succesful connection:
    2006:07:29-10:00:54 (none) pptpd[22697]: CTRL: Client 222.152.11.159 control connection started
    2006:07:29-10:00:54 (none) pptpd[22697]: CTRL: Starting call (launching pppd, opening GRE)
    2006:07:29-10:00:54 (none) pppd-pptp[22698]: Plugin /usr/sbin/aua.so loaded.
    2006:07:29-10:00:54 (none) pppd-pptp[22698]: AUA plugin initialized.
    2006:07:29-10:00:54 (none) pppd-pptp[22698]: Plugin /usr/sbin/aua.so loaded.
    2006:07:29-10:00:54 (none) pppd-pptp[22698]: AUA plugin initialized.
    2006:07:29-10:00:54 (none) pppd-pptp[22698]: pppd 2.4.3 started by (unknown), uid 0
    2006:07:29-10:00:54 (none) pppd-pptp[22698]: Starting negotiation on /dev/ttyp0
    2006:07:29-10:00:54 (none) pptpd[22697]: GRE: Bad checksum from pppd.
    2006:07:29-10:00:55 (none) pptpd[22697]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
    2006:07:29-10:00:57 (none) pppd-pptp[22698]: Using interface ppp0
    2006:07:29-10:00:57 (none) pppd-pptp[22698]: MPPC/MPPE 128-bit stateless compression enabled
    2006:07:29-10:00:57 (none) pppd-pptp[22698]: found interface eth0 for proxy arp
    2006:07:29-10:00:57 (none) pppd-pptp[22698]: local IP address 10.254.254.33
    2006:07:29-10:00:57 (none) pppd-pptp[22698]: remote IP address 10.254.254.35
  • 0 in reply to JeremySherriff
    I have the same problem.

    Failed attempt:

    2006:08:16-09:24:24 (none) pptpd[24813]: CTRL: Client 88.x.x.x control connection started
    2006:08:16-09:24:24 (none) pptpd[24813]: CTRL: Starting call (launching pppd, opening GRE)
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: Plugin /usr/sbin/aua.so loaded.
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: AUA plugin initialized.
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: Plugin /usr/sbin/aua.so loaded.
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: AUA plugin initialized.
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: pppd 2.4.3 started by (unknown), uid 0
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: Starting negotiation on /dev/ttyp0
    2006:08:16-09:24:25 (none) pptpd[24813]: GRE: Bad checksum from pppd.
    2006:08:16-09:24:25 (none) pptpd[24813]: GRE: xmit failed from decaps_hdlc: Operation not permitted
    2006:08:16-09:24:25 (none) pptpd[24813]: CTRL: PTY read or GRE write failed (pty,gre)=(4,5)
    2006:08:16-09:24:25 (none) pptpd[24813]: CTRL: Reaping child PPP[24814]
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: Modem hangup
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: Connection terminated.
    2006:08:16-09:24:25 (none) pppd-pptp[24814]: Exit.
    2006:08:16-09:24:25 (none) pptpd[24813]: CTRL: Client 88.x.x.x control connection finished

    Successfully attempt:

    2006:08:16-09:24:29 (none) pptpd[24815]: CTRL: Client 88.x.x.x control connection started
    2006:08:16-09:24:29 (none) pptpd[24815]: CTRL: Starting call (launching pppd, opening GRE)
    2006:08:16-09:24:29 (none) pppd-pptp[24816]: Plugin /usr/sbin/aua.so loaded.
    2006:08:16-09:24:29 (none) pppd-pptp[24816]: AUA plugin initialized.
    2006:08:16-09:24:29 (none) pppd-pptp[24816]: Plugin /usr/sbin/aua.so loaded.
    2006:08:16-09:24:29 (none) pppd-pptp[24816]: AUA plugin initialized.
    2006:08:16-09:24:29 (none) pppd-pptp[24816]: pppd 2.4.3 started by (unknown), uid 0
    2006:08:16-09:24:29 (none) pppd-pptp[24816]: Starting negotiation on /dev/ttyp0
    2006:08:16-09:24:29 (none) pptpd[24815]: GRE: Bad checksum from pppd.
    2006:08:16-09:24:30 (none) pptpd[24815]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
    2006:08:16-09:24:32 (none) pppd-pptp[24816]: Using interface ppp0
    2006:08:16-09:24:33 (none) pppd-pptp[24816]: MPPC/MPPE 128-bit stateless compression enabled
    2006:08:16-09:24:33 (none) pppd-pptp[24816]: found interface eth2 for proxy arp
    2006:08:16-09:24:33 (none) pppd-pptp[24816]: local  IP address 10.126.76.1
    2006:08:16-09:24:33 (none) pppd-pptp[24816]: remote IP address 10.126.76.2
    2006:08:16-09:29:52 (none) pppd-pptp[24816]: LCP terminated by peer (^J%`M-$^@
  • 0 in reply to cerri
    Jepp, I got the same problem!
  • 0 in reply to drgoebel
    Astaro support have advised a possible fix will be in 6.303..
Reply Children
  • 0 in reply to JeremySherriff
    Good! I'll wait for release 6.303.
  • 0 in reply to cerri
    I have a similar problem:

    I read this error in the debug log:

    2006:08:30-15:12:18 (none) pluto[6687]: | emitting length of ISAKMP Vendor ID Payload: 20
    2006:08:30-15:12:18 (none) pluto[6687]: | emitting length of ISAKMP Message: 196
    2006:08:30-15:12:18 (none) pluto[6687]: | sending 196 bytes for main_outI1 through eth1:500 to xx.xx.xxx.xxx:yyy:
    2006:08:30-15:12:18 (none) pluto[6687]: ERROR: "S_Salerno-Salerno2_0" #1: sendto on eth1 to 8x.xx.xxx.xxx:yyy failed in main_outI1. Errno 1: Operation not permitted
    2006:08:30-15:12:18 (none) pluto[6687]: | inserting event EVENT_RETRANSMIT, timeout in 10 seconds for #1
    2006:08:30-15:12:18 (none) pluto[6687]: | next event EVENT_RETRANSMIT in 10 seconds for #1
    2006:08:30-15:12:28 (none) pluto[6687]: |
    2006:08:30-15:12:28 (none) pluto[6687]: | *time to handle event
    2006:08:30-15:12:28 (none) pluto[6687]: | handling event EVENT_RETRANSMIT
Cookie Information Banner