Thread Info
  • State Not Answered
  • Locked Locked
  • Replies 56 replies
  • Subscribers 1 subscriber
  • Views 29260 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

HELP! PPTP doesn't work anymore!

THoehne
Yesterday I updated my ASL box to 4.008. Since that time the PPTP VPN access doesn't work anymore! I haven't changed any settings. I've already disabled and enabled the PPTP service, but with no effect. The same for deleting and re-creating the user. Can anyone help me?  


This thread was automatically locked due to age.
Parents
  • 0
    You may try to start daemon with -D option, then it should work - ti require the stdin or tty - its a bug I suppose  
  • 0 in reply to kris
    which daemon? pptpd do not have -D option, only -d.
    that's for debug, it doesn't help.  
  • 0 in reply to Chris Lynch
    It definately fixed my connectivity issues but I still get randomly timed disconnects and GRE errors showing up in my logs.  Not sure if they are user OS related or the Astaro box.   
  • 0 in reply to Architectual
    Jul 25 14:09:31 (none) pppd[32683]: CCP: timeout sending Config-Requests 
    Jul 25 14:09:33 (none) pppd[32683]: sent [LCP EchoReq id=0x7 magic=0x2d7ae10d]
    Jul 25 14:09:33 (none) pppd[32683]: rcvd [IPCP ConfReq id=0x10 ]
    Jul 25 14:09:33 (none) pppd[32683]: sent [IPCP TermAck id=0x10]
    Jul 25 14:09:33 (none) pppd[32683]: rcvd [LCP EchoRep id=0x7 magic=0x4d957c2c]
    Jul 25 14:09:37 (none) pptpd[32682]: CTRL: Received PPTP Control Message (type: 15)
    Jul 25 14:09:37 (none) pptpd[32682]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Jul 25 14:09:37 (none) pppd[32683]: rcvd [LCP TermReq id=0x11 "M\37777777625|,\000
  • 0 in reply to asher
    I am in the same boat. I applied the patch and still nothing.  
  • 0 in reply to Deunan
    make sure that 'maximum strength encryption' is enabled.
    (advanced security settings)

    read u
    o|iver  
  • 0 in reply to Deunan
    Hi Deunan and Olivier,

    could you enable debugging of the PPTP server and post the relevant part of the log file as well as your ASL version, etc. ?

    Thanks,
    Stephan
      
  • 0 in reply to Stephan_Scholz
    Our system is at  ASL 4.009
    We are  now experiencing various PPTP VPN problems since upgrading to 4.008 and 4.009.

    Normally it is faiiled connect, but also dropped connections.
    these are most prevalent when use consumer-grade home routers.  

    Attached here are two example logs for Win2K SP4 clients
    using ethernet ports on home wireless/ethernet routers.

    The first is a successful connect via a Linksys BEFW11S4
    with the latest 1.45.3 firmware.

    The second  is unsuccesful via a Netgear MR814v2 with
    the latest 5.01 firmware.  

    This issue is definitely triggered by the routers as
    we can switch them and the problem stays with
    the Netgear and fails everytime.

    Both routers and the ASL box are connected to
    the building's 100 MB/s switched ethernet. We've
    tried playing various games with the MTU size but
    see no difference in the result.

    *****************************************************************************************
    *
    *  Successful PPTP VPN connect from Linksys BEFW11S4
    *
    *****************************************************************************************
    Jul 29 19:31:40 (none) pptpd[3547]: MGR: Launching /usr/local/sbin/pptpctrl to handle client
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: local address = 171.67.73.65
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: remote address = 171.67.73.66
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: pppd options file = /etc/ppp/options
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Client 171.67.77.10 control connection started
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Received PPTP Control Message (type: 1)
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Made a START CTRL CONN RPLY packet
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: I wrote 156 bytes to the client.
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Sent packet to client
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Received PPTP Control Message (type: 7)
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Set parameters to 1525 maxbps, 64 window size
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Made a OUT CALL RPLY packet
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Starting call (launching pppd, opening GRE)
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: pty_fd = 5
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: tty_fd = 6
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: I wrote 32 bytes to the client.
    Jul 29 19:31:40 (none) pptpd[3547]: CTRL: Sent packet to client
    Jul 29 19:31:40 (none) pppd[3548]: pppd 2.4.2b1 started by (unknown), uid 0
    Jul 29 19:31:40 (none) pppd[3548]: using channel 736
    Jul 29 19:31:40 (none) pppd[3548]: Starting negotiation on /dev/ttyp0
    Jul 29 19:31:40 (none) pppd[3548]: sent [LCP ConfReq id=0x1        ]
    Jul 29 19:31:40 (none) pptpd[3548]: CTRL (PPPD Launcher): Connection speed = 115200
    Jul 29 19:31:40 (none) pptpd[3548]: CTRL (PPPD Launcher): local address = 171.67.73.65
    Jul 29 19:31:40 (none) pptpd[3548]: CTRL (PPPD Launcher): remote address = 171.67.73.66
    Jul 29 19:31:40 (none) pptpd[3547]: GRE: Discarding duplicate packet
    Jul 29 19:31:42 (none) pptpd[3547]: CTRL: Received PPTP Control Message (type: 15)
    Jul 29 19:31:42 (none) pptpd[3547]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Jul 29 19:31:43 (none) pppd[3548]: sent [LCP ConfReq id=0x1        ]
    Jul 29 19:32:07 (none) last message repeated 8 times
    Jul 29 19:32:10 (none) pptpd[4925]: MGR: Reaped child 3547
    Jul 29 19:32:10 (none) pptpd[3547]: GRE: read(fd=5,buffer=804dbe0,len=8196) from PTY failed: status = -1 error = Input/output error
    Jul 29 19:32:10 (none) pptpd[3547]: CTRL: PTY read or GRE write failed (pty,gre)=(5,6)
    Jul 29 19:32:10 (none) pptpd[3547]: CTRL: Closing child ppp with pid 3548
    Jul 29 19:32:10 (none) pptpd[3547]: CTRL: Client 171.67.77.10 control connection finished
    Jul 29 19:32:10 (none) pptpd[3547]: CTRL: Exiting now
    Jul 29 19:32:10 (none) pppd[3548]: LCP: timeout sending Config-Requests
    Jul 29 19:32:10 (none) pppd[3548]: Connection terminated.
    Jul 29 19:32:10 (none) pppd[3548]: Exit.
    Jul 29 19:32:14 (none) pptpd[3679]: MGR: Launching /usr/local/sbin/pptpctrl to handle client
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: local address = 171.67.73.65
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: remote address = 171.67.73.67
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: pppd options file = /etc/ppp/options
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Client 171.67.77.10 control connection started
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 1)
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Made a START CTRL CONN RPLY packet
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: I wrote 156 bytes to the client.
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Sent packet to client
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 7)
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Set parameters to 1525 maxbps, 64 window size
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Made a OUT CALL RPLY packet
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Starting call (launching pppd, opening GRE)
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: pty_fd = 5
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: tty_fd = 6
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: I wrote 32 bytes to the client.
    Jul 29 19:32:14 (none) pptpd[3679]: CTRL: Sent packet to client
    Jul 29 19:32:14 (none) pppd[3680]: pppd 2.4.2b1 started by (unknown), uid 0
    Jul 29 19:32:14 (none) pppd[3680]: using channel 737
    Jul 29 19:32:14 (none) pppd[3680]: Starting negotiation on /dev/ttyp0
    Jul 29 19:32:14 (none) pppd[3680]: sent [LCP ConfReq id=0x1        ]
    Jul 29 19:32:14 (none) pptpd[3680]: CTRL (PPPD Launcher): Connection speed = 115200
    Jul 29 19:32:14 (none) pptpd[3680]: CTRL (PPPD Launcher): local address = 171.67.73.65
    Jul 29 19:32:14 (none) pptpd[3680]: CTRL (PPPD Launcher): remote address = 171.67.73.67
    Jul 29 19:32:14 (none) pptpd[3679]: GRE: Discarding duplicate packet
    Jul 29 19:32:15 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 15)
    Jul 29 19:32:15 (none) pptpd[3679]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Jul 29 19:32:16 (none) pppd[3680]: rcvd [LCP ConfReq id=0x1      ]
    Jul 29 19:32:16 (none) pppd[3680]: sent [LCP ConfRej id=0x1 ]
    Jul 29 19:32:16 (none) pppd[3680]: rcvd [LCP ConfReq id=0x2     ]
    Jul 29 19:32:16 (none) pppd[3680]: sent [LCP ConfAck id=0x2     ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x1        ]
    Jul 29 19:32:17 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 15)
    Jul 29 19:32:17 (none) pptpd[3679]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x1  ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x2       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x2 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x3       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x3 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x4       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x4 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x5       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x5 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x6       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x6 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x7       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x7 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x8       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x8 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0x9       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0x9 ]
    Jul 29 19:32:17 (none) aua[401]: flushing cache
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0xa       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfNak id=0xa ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0xb       ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfRej id=0xb ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP ConfReq id=0xc      ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP ConfAck id=0xc      ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP EchoReq id=0x0 magic=0x5358865a]
    Jul 29 19:32:17 (none) pppd[3680]: sent [CHAP Challenge id=0x1 , name = "pptp"]
    Jul 29 19:32:17 (none) aua[3697]: Returning password hash for user graphics [623D6436C27C07E571AE475938042138:*]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP code=0xc id=0x3 6b ba 3b cb 4d 53 52 41 53 56 35 2e 30 30]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP CodeRej id=0xd 0c 03 00 12 6b ba 3b cb 4d 53 52 41 53 56 35 2e 30 30]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP code=0xc id=0x4 6b ba 3b cb 4d 53 52 41 53 2d 31 2d 44 41 46 46 59]
    Jul 29 19:32:17 (none) pppd[3680]: sent [LCP CodeRej id=0xe 0c 04 00 15 6b ba 3b cb 4d 53 52 41 53 2d 31 2d 44 41 46 46 59]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [LCP EchoRep id=0x0 magic=0x6bba3bcb]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [CHAP Response id=0x1 , name = "graphics"]
    Jul 29 19:32:17 (none) pppd[3680]: No CHAP secret found for authenticating graphics, trying aua now.
    Jul 29 19:32:17 (none) pppd[3680]: sent [CHAP Success id=0x1 "S=5A370DDBD736CF285F5829021B1BF8486C72BE94 M=Welcome to agp.stanford.edu.stanford.edu."]
    Jul 29 19:32:17 (none) pppd[3680]: Using interface ppp0
    Jul 29 19:32:17 (none) pppd[3680]: sent [CCP ConfReq id=0x1 ]
    Jul 29 19:32:17 (none) pppd[3680]: CHAP peer authentication succeeded for graphics
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [CCP ConfReq id=0x5 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [CCP ConfNak id=0x5 ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [IPCP ConfReq id=0x6 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [IPCP TermAck id=0x6]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [CCP ConfAck id=0x1 ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [CCP ConfReq id=0x7 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [CCP ConfAck id=0x7 ]
    Jul 29 19:32:17 (none) pppd[3680]: MPPE 128-bit stateless compression enabled
    Jul 29 19:32:17 (none) pppd[3680]: sent [IPCP ConfReq id=0x1  ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [IPCP ConfRej id=0x1 ]
    Jul 29 19:32:17 (none) pppd[3680]: sent [IPCP ConfReq id=0x2 ]
    Jul 29 19:32:17 (none) pppd[3680]: rcvd [IPCP ConfAck id=0x2 ]
    Jul 29 19:32:20 (none) pppd[3680]: rcvd [IPCP ConfReq id=0x8 ]
    Jul 29 19:32:20 (none) pppd[3680]: sent [IPCP ConfNak id=0x8 ]
    Jul 29 19:32:20 (none) pppd[3680]: rcvd [IPCP ConfReq id=0x9 ]
    Jul 29 19:32:20 (none) pppd[3680]: sent [IPCP ConfAck id=0x9 ]
    Jul 29 19:32:20 (none) pppd[3680]: found interface eth1 for proxy arp
    Jul 29 19:32:20 (none) pppd[3680]: local  IP address 171.67.73.65
    Jul 29 19:32:20 (none) pppd[3680]: remote IP address 171.67.73.67
    Jul 29 19:32:22 (none) pppd[3680]: sent [LCP EchoReq id=0x1 magic=0x5358865a]
    Jul 29 19:32:26 (none) pppd[3680]: rcvd [LCP EchoRep id=0x1 magic=0x6bba3bcb]
    Jul 29 19:32:27 (none) pppd[3680]: sent [LCP EchoReq id=0x2 magic=0x5358865a]
    Jul 29 19:32:27 (none) pppd[3680]: rcvd [LCP EchoRep id=0x2 magic=0x6bba3bcb]
    Jul 29 19:32:32 (none) pppd[3680]: sent [LCP EchoReq id=0x3 magic=0x5358865a]
    Jul 29 19:32:32 (none) pppd[3680]: rcvd [LCP EchoRep id=0x3 magic=0x6bba3bcb]
    Jul 29 19:32:37 (none) pppd[3680]: sent [LCP EchoReq id=0x4 magic=0x5358865a]
    Jul 29 19:32:37 (none) pppd[3680]: rcvd [LCP EchoRep id=0x4 magic=0x6bba3bcb]
    Jul 29 19:32:42 (none) pppd[3680]: sent [LCP EchoReq id=0x5 magic=0x5358865a]
    Jul 29 19:32:42 (none) pppd[3680]: rcvd [LCP EchoRep id=0x5 magic=0x6bba3bcb]
    Jul 29 19:32:47 (none) pppd[3680]: sent [LCP EchoReq id=0x6 magic=0x5358865a]
    Jul 29 19:32:47 (none) pppd[3680]: rcvd [LCP EchoRep id=0x6 magic=0x6bba3bcb]
    Jul 29 19:32:52 (none) pppd[3680]: sent [LCP EchoReq id=0x7 magic=0x5358865a]
    Jul 29 19:32:52 (none) pppd[3680]: rcvd [LCP EchoRep id=0x7 magic=0x6bba3bcb]
    Jul 29 19:32:57 (none) pppd[3680]: sent [LCP EchoReq id=0x8 magic=0x5358865a]
    Jul 29 19:32:57 (none) pppd[3680]: rcvd [LCP EchoRep id=0x8 magic=0x6bba3bcb]
    Jul 29 19:33:02 (none) pppd[3680]: sent [LCP EchoReq id=0x9 magic=0x5358865a]
    Jul 29 19:33:02 (none) pppd[3680]: rcvd [LCP EchoRep id=0x9 magic=0x6bba3bcb]
    Jul 29 19:33:07 (none) pppd[3680]: sent [LCP EchoReq id=0xa magic=0x5358865a]
    Jul 29 19:33:07 (none) pppd[3680]: rcvd [LCP EchoRep id=0xa magic=0x6bba3bcb]
    Jul 29 19:33:12 (none) pppd[3680]: sent [LCP EchoReq id=0xb magic=0x5358865a]
    Jul 29 19:33:12 (none) pppd[3680]: rcvd [LCP EchoRep id=0xb magic=0x6bba3bcb]
    Jul 29 19:33:14 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 5)
    Jul 29 19:33:14 (none) pptpd[3679]: CTRL: Made a ECHO RPLY packet
    Jul 29 19:33:14 (none) pptpd[3679]: CTRL: I wrote 20 bytes to the client.
    Jul 29 19:33:14 (none) pptpd[3679]: CTRL: Sent packet to client
    Jul 29 19:33:14 (none) named[4270]: Cleaned cache of 3443 RRsets
    Jul 29 19:33:14 (none) named[4270]: USAGE 1059507194 1058567593 CPU=281.5u/115.71s CHILDCPU=0u/0s
    Jul 29 19:33:14 (none) named[4270]: NSTATS 1059507194 1058567593 A=387263 PTR=1448988 MX=17198 TXT=1149 AAAA=5606
    Jul 29 19:33:14 (none) named[4270]: XSTATS 1059507194 1058567593 RR=964059 RNXD=549150 RFwdR=5520 RDupR=13095 RFail=231448 RFErr=0 RErr=0 RAXFR=0 RLame=0 ROpts=0 SSysQ=414418 SAns=2180475 SFwdQ=341289 SDupQ=230141 SErr=0 RQ=1860204 RIQ=0 RFwdQ=341289 RDupQ=2066 RTCP=1308 SFwdR=5520 SFail=82 SFErr=0 SNaAns=1789771 SNXD=459637 RUQ=0 RURQ=0 RUXFR=0 RUUpd=0
    Jul 29 19:33:17 (none) pppd[3680]: sent [LCP EchoReq id=0xc magic=0x5358865a]
    Jul 29 19:33:17 (none) pppd[3680]: rcvd [LCP EchoRep id=0xc magic=0x6bba3bcb]
    Jul 29 19:33:22 (none) pppd[3680]: sent [LCP EchoReq id=0xd magic=0x5358865a]
    Jul 29 19:33:22 (none) pppd[3680]: rcvd [LCP EchoRep id=0xd magic=0x6bba3bcb]
    Jul 29 19:33:27 (none) pppd[3680]: sent [LCP EchoReq id=0xe magic=0x5358865a]
    Jul 29 19:33:27 (none) pppd[3680]: rcvd [LCP EchoRep id=0xe magic=0x6bba3bcb]
    Jul 29 19:33:32 (none) pppd[3680]: sent [LCP EchoReq id=0xf magic=0x5358865a]
    Jul 29 19:33:32 (none) pppd[3680]: rcvd [LCP EchoRep id=0xf magic=0x6bba3bcb]
    Jul 29 19:33:37 (none) pppd[3680]: sent [LCP EchoReq id=0x10 magic=0x5358865a]
    Jul 29 19:33:37 (none) pppd[3680]: rcvd [LCP EchoRep id=0x10 magic=0x6bba3bcb]
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 15)
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Jul 29 19:33:41 (none) pptpd[4925]: MGR: Reaped child 3679
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 12)
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Made a CALL DISCONNECT RPLY packet
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Received CALL CLR request (closing call)
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: I wrote 148 bytes to the client.
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Sent packet to client
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Received PPTP Control Message (type: 3)
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Made a STOP CTRL CONN RPLY packet
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Received STOP CTRL CONN request (disconnecting)
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: I wrote 16 bytes to the client.
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Sent packet to client
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Closing child ppp with pid 3680
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Client 171.67.77.10 control connection finished
    Jul 29 19:33:41 (none) pptpd[3679]: CTRL: Exiting now
    Jul 29 19:33:41 (none) pppd[3680]: rcvd [LCP TermReq id=0xa "k\37777777672;\37777777713\000       ]
    Jul 29 19:34:30 (none) pptpd[4240]: CTRL (PPPD Launcher): Connection speed = 115200
    Jul 29 19:34:30 (none) pptpd[4240]: CTRL (PPPD Launcher): local address = 171.67.73.65
    Jul 29 19:34:30 (none) pptpd[4240]: CTRL (PPPD Launcher): remote address = 171.67.73.66
    Jul 29 19:34:30 (none) pptpd[4239]: CTRL: Received PPTP Control Message (type: 15)
    Jul 29 19:34:30 (none) pptpd[4239]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Jul 29 19:34:30 (none) pptpd[4239]: GRE: Discarding duplicate packet
    Jul 29 19:34:33 (none) pppd[4240]: sent [LCP ConfReq id=0x1        ]
    Jul 29 19:34:57 (none) last message repeated 8 times
    Jul 29 19:35:00 (none) pptpd[4925]: MGR: Reaped child 4239
    Jul 29 19:35:00 (none) pptpd[4239]: GRE: read(fd=5,buffer=804dbe0,len=8196) from PTY failed: status = -1 error = Input/output error
    Jul 29 19:35:00 (none) pptpd[4239]: CTRL: PTY read or GRE write failed (pty,gre)=(5,6)
    Jul 29 19:35:00 (none) pptpd[4239]: CTRL: Closing child ppp with pid 4240
    Jul 29 19:35:00 (none) pptpd[4239]: CTRL: Client 172.24.77.28 control connection finished
    Jul 29 19:35:00 (none) pptpd[4239]: CTRL: Exiting now
    Jul 29 19:35:00 (none) pppd[4240]: LCP: timeout sending Config-Requests
    Jul 29 19:35:00 (none) pppd[4240]: Connection terminated.
    Jul 29 19:35:00 (none) pppd[4240]: Exit.

      
  • 0 in reply to JGerth
    Hey Gert, Oliver, & everybody. . .are we any closer to seeing an up2date that fixes this issue? [:S]  
  • 0 in reply to martindw
    okay this is getting to be ridiculous...people need this to be working....clients need this to be working...I NEED THIS TO BE WORKING....this is vvvery unprofessional of asl......

    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Client 66.134.169.168 control connection started
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Received PPTP Control Message (type: 1)
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Made a START CTRL CONN RPLY packet
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: I wrote 156 bytes to the client.
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Sent packet to client
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Received PPTP Control Message (type: 7)
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Set parameters to 1525 maxbps, 64 window size
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Made a OUT CALL RPLY packet
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Starting call (launching pppd, opening GRE)
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: pty_fd = 5
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: tty_fd = 6
    Aug  8 14:36:09 (none) pptpd[6548]: CTRL (PPPD Launcher): Connection speed = 115200
    Aug  8 14:36:09 (none) pptpd[6548]: CTRL (PPPD Launcher): local address = 10.242.37.1
    Aug  8 14:36:09 (none) pptpd[6548]: CTRL (PPPD Launcher): remote address = 10.242.37.2
    Aug  8 14:36:09 (none) pppd[6548]: pppd 2.4.2b1 started by (unknown), uid 0
    Aug  8 14:36:09 (none) pppd[6548]: using channel 70
    Aug  8 14:36:09 (none) pppd[6548]: Starting negotiation on /dev/ttyp0
    Aug  8 14:36:09 (none) pppd[6548]: sent [LCP ConfReq id=0x1        ]
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: I wrote 32 bytes to the client.
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Sent packet to client
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Received PPTP Control Message (type: 15)
    Aug  8 14:36:09 (none) pptpd[6547]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Aug  8 14:36:09 (none) pptpd[6547]: GRE: Discarding duplicate packet
    Aug  8 14:36:09 (none) pppd[6548]: rcvd [LCP ConfRej id=0x1  ]
    Aug  8 14:36:09 (none) pppd[6548]: sent [LCP ConfReq id=0x2      ]
    Aug  8 14:36:09 (none) pppd[6548]: rcvd [LCP ConfAck id=0x2      ]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [LCP ConfReq id=0x1     ]
    Aug  8 14:36:11 (none) pppd[6548]: sent [LCP ConfRej id=0x1 ]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [LCP ConfReq id=0x2    ]
    Aug  8 14:36:11 (none) pppd[6548]: sent [LCP ConfAck id=0x2    ]
    Aug  8 14:36:11 (none) pppd[6548]: sent [LCP EchoReq id=0x0 magic=0x7924d1dc]
    Aug  8 14:36:11 (none) pppd[6548]: sent [CHAP Challenge id=0x1 , name = "pptp"]
    Aug  8 14:36:11 (none) pptpd[6547]: CTRL: Received PPTP Control Message (type: 15)
    Aug  8 14:36:11 (none) pptpd[6547]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [LCP code=0xc id=0x3 1e 73 3e 0b 4d 53 52 41 53 56 35 2e 31 30]
    Aug  8 14:36:11 (none) pppd[6548]: sent [LCP CodeRej id=0x3 0c 03 00 12 1e 73 3e 0b 4d 53 52 41 53 56 35 2e 31 30]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [LCP code=0xc id=0x4 1e 73 3e 0b 4d 53 52 41 53 2d 31 2d 41 54 4f 50 4f 52 4f 56 53 4b 59]
    Aug  8 14:36:11 (none) pppd[6548]: sent [LCP CodeRej id=0x4 0c 04 00 1b 1e 73 3e 0b 4d 53 52 41 53 2d 31 2d 41 54 4f 50 4f 52 4f 56 53 4b 59]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [LCP EchoRep id=0x0 magic=0x1e733e0b]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [CHAP Response id=0x1 ?db37a09fa6ede1670ee34e1d000000000000000024111af491df1212b08da802c13b53036f4fd490e502f57b00>, name = "asher"]
    Aug  8 14:36:11 (none) pppd[6548]: No CHAP secret found for authenticating asher, trying aua now.
    Aug  8 14:36:11 (none) pppd[6548]: sent [CHAP Success id=0x1 "S=F43EB2B8100EAFF293A1606F4593F1975252CF95 M=Welcome to nyc.toporovsky.com."]
    Aug  8 14:36:11 (none) pppd[6548]: Using interface ppp0
    Aug  8 14:36:11 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:11 (none) pppd[6548]: CHAP peer authentication succeeded for asher
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [CCP ConfReq id=0x5 ]
    Aug  8 14:36:11 (none) pppd[6548]: sent [CCP ConfRej id=0x5 ]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [IPCP ConfReq id=0x6     ]
    Aug  8 14:36:11 (none) pppd[6548]: sent [IPCP TermAck id=0x6]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [CCP ConfAck id=0x1 ]
    Aug  8 14:36:11 (none) pppd[6548]: rcvd [CCP TermReq id=0x7 1e 73 3e 0b 00 3c cd 74 00 00 02 dc]
    Aug  8 14:36:11 (none) pppd[6548]: sent [CCP TermAck id=0x7]
    Aug  8 14:36:14 (none) pppd[6548]: rcvd [IPCP ConfReq id=0x8     ]
    Aug  8 14:36:14 (none) pppd[6548]: sent [IPCP TermAck id=0x8]
    Aug  8 14:36:14 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:14 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:16 (none) pppd[6548]: sent [LCP EchoReq id=0x1 magic=0x7924d1dc]
    Aug  8 14:36:16 (none) pppd[6548]: rcvd [LCP EchoRep id=0x1 magic=0x1e733e0b]
    Aug  8 14:36:17 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:17 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:18 (none) pppd[6548]: rcvd [IPCP ConfReq id=0x9     ]
    Aug  8 14:36:18 (none) pppd[6548]: sent [IPCP TermAck id=0x9]
    Aug  8 14:36:20 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:20 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:21 (none) pppd[6548]: sent [LCP EchoReq id=0x2 magic=0x7924d1dc]
    Aug  8 14:36:21 (none) pppd[6548]: rcvd [LCP EchoRep id=0x2 magic=0x1e733e0b]
    Aug  8 14:36:22 (none) pppd[6548]: rcvd [IPCP ConfReq id=0xa     ]
    Aug  8 14:36:22 (none) pppd[6548]: sent [IPCP TermAck id=0xa]
    Aug  8 14:36:23 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:23 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:26 (none) pppd[6548]: sent [LCP EchoReq id=0x3 magic=0x7924d1dc]
    Aug  8 14:36:26 (none) pppd[6548]: rcvd [IPCP ConfReq id=0xb ]
    Aug  8 14:36:26 (none) pppd[6548]: sent [IPCP TermAck id=0xb]
    Aug  8 14:36:26 (none) pppd[6548]: rcvd [LCP EchoRep id=0x3 magic=0x1e733e0b]
    Aug  8 14:36:26 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:26 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:29 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:29 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:30 (none) pppd[6548]: rcvd [IPCP ConfReq id=0xc ]
    Aug  8 14:36:30 (none) pppd[6548]: sent [IPCP TermAck id=0xc]
    Aug  8 14:36:31 (none) pppd[6548]: sent [LCP EchoReq id=0x4 magic=0x7924d1dc]
    Aug  8 14:36:31 (none) pppd[6548]: rcvd [LCP EchoRep id=0x4 magic=0x1e733e0b]
    Aug  8 14:36:32 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:32 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:34 (none) pppd[6548]: rcvd [IPCP ConfReq id=0xd ]
    Aug  8 14:36:34 (none) pppd[6548]: sent [IPCP TermAck id=0xd]
    Aug  8 14:36:35 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:35 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:36 (none) pppd[6548]: sent [LCP EchoReq id=0x5 magic=0x7924d1dc]
    Aug  8 14:36:36 (none) pppd[6548]: rcvd [LCP EchoRep id=0x5 magic=0x1e733e0b]
    Aug  8 14:36:38 (none) pppd[6548]: rcvd [IPCP ConfReq id=0xe ]
    Aug  8 14:36:38 (none) pppd[6548]: sent [IPCP TermAck id=0xe]
    Aug  8 14:36:38 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:38 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:41 (none) pppd[6548]: sent [LCP EchoReq id=0x6 magic=0x7924d1dc]
    Aug  8 14:36:41 (none) pppd[6548]: rcvd [LCP EchoRep id=0x6 magic=0x1e733e0b]
    Aug  8 14:36:41 (none) pppd[6548]: sent [CCP ConfReq id=0x1 ]
    Aug  8 14:36:41 (none) pppd[6548]: rcvd [CCP TermAck id=0x1 12 06 01 00 00 40]
    Aug  8 14:36:42 (none) pppd[6548]: rcvd [IPCP ConfReq id=0xf ]
    Aug  8 14:36:42 (none) pppd[6548]: sent [IPCP TermAck id=0xf]
    Aug  8 14:36:44 (none) pppd[6548]: CCP: timeout sending Config-Requests 
    Aug  8 14:36:46 (none) pppd[6548]: rcvd [IPCP ConfReq id=0x10 ]
    Aug  8 14:36:46 (none) pppd[6548]: sent [IPCP TermAck id=0x10]
    Aug  8 14:36:46 (none) pppd[6548]: sent [LCP EchoReq id=0x7 magic=0x7924d1dc]
    Aug  8 14:36:46 (none) pppd[6548]: rcvd [LCP EchoRep id=0x7 magic=0x1e733e0b]
    Aug  8 14:36:50 (none) pptpd[6547]: CTRL: Received PPTP Control Message (type: 15)
    Aug  8 14:36:50 (none) pptpd[6547]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Aug  8 14:36:50 (none) pppd[6548]: rcvd [LCP TermReq id=0x11 1e 73 3e 0b 00 3c cd 74 00 00 00 00]
    Aug  8 14:36:50 (none) pppd[6548]: LCP terminated by peer (^^s>^K^@
  • 0 in reply to asher
    What client OS is trying to connect?  I have a Windows XP Pro w/SP1, High Encryption and fully patched (verified by HFNETCHKPro) and I can connect on the first attempt. 
  • 0 in reply to Chris Lynch
    ok....i changed my settings to high encryption...this was not required before and now i a connecting on the first try...thanks for the assistance

    I would like to apologize to asl for being so short with them this was just getting annoying allready

    thanks

    asher
     [:$] 
Reply
  • 0 in reply to Chris Lynch
    ok....i changed my settings to high encryption...this was not required before and now i a connecting on the first try...thanks for the assistance

    I would like to apologize to asl for being so short with them this was just getting annoying allready

    thanks

    asher
     [:$] 
Children
  • 0 in reply to asher
    Just wanted to bump this thread so it doesn't get lost.  I have word from ASL that this will be fixed "in an upcoming kernel upgrade" but no indication as to how soon.  Frustrating since it means I have to stay back on 4.007 till they get it fixed, but I can't do without PPTP.  [:(]

    I wish they'd put this on the "known issues" list but I can't get an answer to why they don't.

    Keep on holding your breath, everybody! [:$]  
Cookie Information Banner