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

Helmdach
Hello everybody,
a made a PPTP - Roudwarrior connection from my notebook
to my LAN, but I can't see anything. Ping works fine, but nothing else. Here is the logfile:


Aug 18 12:55:26 (none) pptpd[6356]: MGR: Maximum of 100 connections available
Aug 18 12:55:37 (none) pptpd[6440]: CTRL: Client xxx.xxx.xxx.xxx control connection started
Aug 18 12:55:37 (none) pptpd[6440]: CTRL: Starting call (launching pppd, opening GRE)
Aug 18 12:55:37 (none) pppd[6445]: Plugin /usr/sbin/radius.so loaded.
Aug 18 12:55:37 (none) pppd[6445]: RADIUS plugin initialized.
Aug 18 12:55:37 (none) pppd[6445]: Plugin /usr/sbin/radattr.so loaded.
Aug 18 12:55:37 (none) pppd[6445]: RADATTR plugin initialized.
Aug 18 12:55:37 (none) pptpd[6440]: GRE: Bad checksum from pppd.
Aug 18 12:55:37 (none) pppd[6445]: Plugin /usr/sbin/radius.so loaded.
Aug 18 12:55:37 (none) pppd[6445]: RADIUS plugin initialized.
Aug 18 12:55:37 (none) pppd[6445]: Plugin /usr/sbin/radattr.so loaded.
Aug 18 12:55:37 (none) pppd[6445]: RADATTR plugin initialized.
Aug 18 12:55:37 (none) pppd[6445]: pppd 2.4.2b1 started by (unknown), uid 0
Aug 18 12:55:37 (none) pppd[6445]: Starting negotiation on /dev/ttyp0
Aug 18 12:55:37 (none) pptpd[6440]: GRE: Discarding duplicate packet
Aug 18 12:55:39 (none) pptpd[6440]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
Aug 18 12:55:40 (none) pppd[6445]: rc_map2id: can't find tty /dev/ in map database
Aug 18 12:55:40 (none) pppd[6445]: Using interface ppp0
Aug 18 12:55:40 (none) pppd[6445]: CHAP peer authentication succeeded for XXXXXXX\Harald.Helmdach
Aug 18 12:55:40 (none) pppd[6445]: MPPE 128-bit stateless compression enabled
Aug 18 12:55:44 (none) pppd[6445]: found interface eth0 for proxy arp
Aug 18 12:55:44 (none) pppd[6445]: local  IP address 192.168.XXX.XXX
Aug 18 12:55:44 (none) pppd[6445]: remote IP address 192.168.XXX.XXX
Aug 18 12:56:14 (none) pppd[6445]: rc_ip_hostname: couldn't look up host by addr: C0A82001
Aug 18 12:56:14 (none) pppd[6445]: rc_send_server: no reply from RADIUS server unknown:1813
Aug 18 12:56:14 (none) pppd[6445]: Accounting START failed for XXXXXXXX\Harald.Helmdach
Aug 18 12:56:44 (none) pppd[6445]: rc_ip_hostname: couldn't look up host by addr: C0A82001
Aug 18 12:56:44 (none) pppd[6445]: rc_send_server: no reply from RADIUS server unknown:1813
Aug 18 12:56:44 (none) pppd[6445]: Accounting START failed for XXXXXXXX\Harald.Helmdach

Hope someone can help me!
   


This thread was automatically locked due to age.
Parents
  • 0
    Hi Harald,

    looks like something is wrong with your DNS setup. Can you check the settings ?
    If this doesn't help, could you enable debugging and post the log again ?

    Regards,
    Stephan
      
  • 0 in reply to Stephan_Scholz
    Tanks for answer,

    DNS is fine.
    All works well, including a SecIP VPN bedween two LAN's.
    Only PPTP Roadwarrior not works.
    Its connect, i can ping all in the lan by Ip adress,
    but not by name.
    Hope you can help me.  
  • 0 in reply to Helmdach
    Do you have the DNS proxy activated ? (Proxies->DNS->Forwarding name servers)
    Do you have a resolvable (!) name for both your machine (System->Settings->Hostname) and your RADIUS server ?
    What does the entry for the RADIUS server look like ? (System->User authentication->Radius Server->Address) ? Is it a DNS name or an IP address ?

    Stephan
       
  • 0 in reply to Stephan_Scholz
    Dear Stephan,

    DNS - Proxy activated with forwarder.
    Radius - Server is an IP Adress. Name in this field is impossible (error form ASL).

    I have no further idea. 
      
  • 0 in reply to Helmdach
    Could you set PPTP debugging to "extensive" and post the log for an unsuccessful connection attempt ? Thanks.

    Stephan
      
  • 0 in reply to Stephan_Scholz
    Hello Stephan,

    here is the extensive protokoll you want:

    Aug 19 09:17:03 (none) pptpd[1949]: CTRL: Client 195.16.34.34 control connection started
    Aug 19 09:17:03 (none) pptpd[1949]: CTRL: Received PPTP Control Message (type: 1)
    Aug 19 09:17:03 (none) pptpd[1949]: CTRL: Made a START CTRL CONN RPLY packet
    Aug 19 09:17:03 (none) pptpd[1949]: CTRL: I wrote 156 bytes to the client.
    Aug 19 09:17:03 (none) pptpd[1949]: CTRL: Sent packet to client
    Aug 19 09:17:04 (none) pptpd[1949]: CTRL: Received PPTP Control Message (type: 7)
    Aug 19 09:17:04 (none) pptpd[1949]: CTRL: Set parameters to 1525 maxbps, 64 window size
    Aug 19 09:17:04 (none) pptpd[1949]: CTRL: Made a OUT CALL RPLY packet
    Aug 19 09:17:04 (none) pptpd[1949]: CTRL: Starting call (launching pppd, opening GRE)
    Aug 19 09:17:05 (none) pptpd[1949]: CTRL: pty_fd = 5
    Aug 19 09:17:05 (none) pptpd[1949]: CTRL: tty_fd = 6
    Aug 19 09:17:05 (none) pptpd[1949]: CTRL: I wrote 32 bytes to the client.
    Aug 19 09:17:05 (none) pptpd[1949]: CTRL: Sent packet to client
    Aug 19 09:17:05 (none) pptpd[1961]: CTRL (PPPD Launcher): Connection speed = 115200
    Aug 19 09:17:05 (none) pptpd[1961]: CTRL (PPPD Launcher): local address = 192.168.32.1
    Aug 19 09:17:05 (none) pptpd[1961]: CTRL (PPPD Launcher): remote address = 192.168.32.2
    Aug 19 09:17:05 (none) pptpd[1949]: CTRL: Received PPTP Control Message (type: 15)
    Aug 19 09:17:05 (none) pptpd[1949]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    Aug 19 09:17:05 (none) pptpd[1949]: GRE: Discarding duplicate packet
    Aug 19 09:17:05 (none) pppd[1961]: Plugin /usr/sbin/radius.so loaded.
    Aug 19 09:17:05 (none) pppd[1961]: RADIUS plugin initialized.
    Aug 19 09:17:05 (none) pppd[1961]: Plugin /usr/sbin/radattr.so loaded.
    Aug 19 09:17:05 (none) pppd[1961]: RADATTR plugin initialized.
    Aug 19 09:17:06 (none) pppd[1961]: Plugin /usr/sbin/radius.so loaded.
    Aug 19 09:17:06 (none) pppd[1961]: RADIUS plugin initialized.
    Aug 19 09:17:06 (none) pppd[1961]: Plugin /usr/sbin/radattr.so loaded.
    Aug 19 09:17:06 (none) pppd[1961]: RADATTR plugin initialized.
    Aug 19 09:17:06 (none) pppd[1961]: pppd 2.4.2b1 started by (unknown), uid 0
    Aug 19 09:17:06 (none) pppd[1961]: using channel 1
    Aug 19 09:17:06 (none) pppd[1961]: Starting negotiation on /dev/ttyp0
    Aug 19 09:17:06 (none) pppd[1961]: sent [LCP ConfReq id=0x1        ]
    Aug 19 09:17:06 (none) pppd[1961]: rcvd [LCP ConfReq id=0x1     ]
    Aug 19 09:17:06 (none) pptpd[1949]: GRE: Bad checksum from pppd.
    Aug 19 09:17:06 (none) pppd[1961]: sent [LCP ConfRej id=0x1 ]
    Aug 19 09:17:06 (none) pppd[1961]: rcvd [LCP ConfRej id=0x1  ]
    Aug 19 09:17:06 (none) pppd[1961]: sent [LCP ConfReq id=0x2      ]
    Aug 19 09:17:06 (none) pppd[1961]: rcvd [LCP ConfReq id=0x2    ]
    Aug 19 09:17:06 (none) pppd[1961]: sent [LCP ConfAck id=0x2    ]
    Aug 19 09:17:06 (none) pptpd[1949]: CTRL: Received PPTP Control Message (type: 15)
    Aug 19 09:17:06 (none) pptpd[1949]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
    Aug 19 09:17:06 (none) pppd[1961]: rcvd [LCP ConfAck id=0x2      ]
    Aug 19 09:17:06 (none) pppd[1961]: sent [LCP EchoReq id=0x0 magic=0x9659191c]
    Aug 19 09:17:06 (none) pppd[1961]: sent [CHAP Challenge id=0x1 ?e41bcfdcca8a64a79259179f7ba>, name = "pptp"]
    Aug 19 09:17:06 (none) pppd[1961]: rcvd [LCP code=0xc id=0x3 49 05 4e 34 4d 53 52 41 53 56 35 2e 31 30]
    Aug 19 09:17:06 (none) pppd[1961]: sent [LCP CodeRej id=0x3 0c 03 00 12 49 05 4e 34 4d 53 52 41 53 56 35 2e 31 30]
    Aug 19 09:17:06 (none) pppd[1961]: rcvd [LCP code=0xc id=0x4 49 05 4e 34 4d 53 52 41 53 2d 31 2d 54 47 45 2d 56 52 30 33 32 30 31 32]
    Aug 19 09:17:06 (none) pppd[1961]: sent [LCP CodeRej id=0x4 0c 04 00 1c 49 05 4e 34 4d 53 52 41 53 2d 31 2d 54 47 45 2d 56 52 30 33 32 30 31 32]
    Aug 19 09:17:07 (none) pppd[1961]: rcvd [LCP EchoRep id=0x0 magic=0x49054e34]
    Aug 19 09:17:07 (none) pppd[1961]: rcvd [CHAP Response id=0x1 , name = "TALLY\Harald.Helmdach"]
    Aug 19 09:17:07 (none) pppd[1961]: rc_map2id: can't find tty /dev/ in map database
    Aug 19 09:17:09 (none) pppd[1961]: sent [CHAP Success id=0x1 "S=089466828B2748B2A481725C450B262192A38EFA M=Welcome to VPN.TALLY.RU.TALLY."]
    Aug 19 09:17:09 (none) pppd[1961]: Using interface ppp0
    Aug 19 09:17:09 (none) pppd[1961]: sent [CCP ConfReq id=0x1 ]
    Aug 19 09:17:09 (none) pppd[1961]: CHAP peer authentication succeeded for TALLY\Harald.Helmdach
    Aug 19 09:17:09 (none) pppd[1961]: rcvd [CHAP Response id=0x1 , name = "TALLY\Harald.Helmdach"]
    Aug 19 09:17:09 (none) pppd[1961]: sent [CHAP Success id=0x1 "S=089466828B2748B2A481725C450B262192A38EFA M=Welcome to VPN.TALLY.RU.TALLY."]
    Aug 19 09:17:09 (none) pppd[1961]: rcvd [CCP ConfReq id=0x5 ]
    Aug 19 09:17:09 (none) pppd[1961]: sent [CCP ConfNak id=0x5 ]
    Aug 19 09:17:09 (none) pppd[1961]: rcvd [IPCP ConfReq id=0x6     ]
    Aug 19 09:17:09 (none) pppd[1961]: sent [IPCP TermAck id=0x6]
    Aug 19 09:17:09 (none) pppd[1961]: rcvd [CCP ConfAck id=0x1 ]
    Aug 19 09:17:09 (none) pppd[1961]: rcvd [CCP ConfReq id=0x7 ]
    Aug 19 09:17:09 (none) pppd[1961]: sent [CCP ConfAck id=0x7 ]
    Aug 19 09:17:09 (none) pppd[1961]: MPPE 128-bit stateless compression enabled
    Aug 19 09:17:09 (none) pppd[1961]: sent [IPCP ConfReq id=0x1  ]
    Aug 19 09:17:09 (none) pppd[1961]: rcvd [IPCP ConfRej id=0x1 ]
    Aug 19 09:17:09 (none) pppd[1961]: sent [IPCP ConfReq id=0x2 ]
    Aug 19 09:17:10 (none) pppd[1961]: rcvd [IPCP ConfAck id=0x2 ]
    Aug 19 09:17:11 (none) pppd[1961]: sent [LCP EchoReq id=0x1 magic=0x9659191c]
    Aug 19 09:17:12 (none) pppd[1961]: rcvd [LCP EchoRep id=0x1 magic=0x49054e34]
    Aug 19 09:17:12 (none) pppd[1961]: rcvd [IPCP ConfReq id=0x8     ]
    Aug 19 09:17:12 (none) pppd[1961]: sent [IPCP ConfNak id=0x8     ]
    Aug 19 09:17:12 (none) pppd[1961]: rcvd [IPCP ConfReq id=0x9     ]
    Aug 19 09:17:12 (none) pppd[1961]: sent [IPCP ConfAck id=0x9     ]
    Aug 19 09:17:12 (none) pppd[1961]: found interface eth0 for proxy arp
    Aug 19 09:17:12 (none) pppd[1961]: local  IP address 192.168.32.1
    Aug 19 09:17:12 (none) pppd[1961]: remote IP address 192.168.32.105
    Aug 19 09:17:42 (none) pppd[1961]: rc_ip_hostname: couldn't look up host by addr: C0A82001
    Aug 19 09:17:42 (none) pppd[1961]: rc_send_server: no reply from RADIUS server unknown:1813
    Aug 19 09:17:42 (none) pppd[1961]: Accounting START failed for TALLY\Harald.Helmdach
    Aug 19 09:18:02 (none) pptpd[1949]: CTRL: Received PPTP Control Message (type: 5)
    Aug 19 09:18:02 (none) pptpd[1949]: CTRL: Made a ECHO RPLY packet
    Aug 19 09:18:02 (none) pptpd[1949]: CTRL: I wrote 20 bytes to the client.
    Aug 19 09:18:02 (none) pptpd[1949]: CTRL: Sent packet to client
    Aug 19 09:18:12 (none) pppd[1961]: rc_ip_hostname: couldn't look up host by addr: C0A82001
    Aug 19 09:18:12 (none) pppd[1961]: rc_send_server: no reply from RADIUS server unknown:1813
    Aug 19 09:18:12 (none) pppd[1961]: Accounting START failed for TALLY\Harald.Helmdach
    Aug 19 09:18:12 (none) pppd[1961]: sent [LCP EchoReq id=0x2 magic=0x9659191c]
    Aug 19 09:18:12 (none) pppd[1961]: rcvd [LCP EchoRep id=0x2 magic=0x49054e34]
    Aug 19 09:18:17 (none) pppd[1961]: sent [LCP EchoReq id=0x3 magic=0x9659191c]
    Aug 19 09:18:17 (none) pppd[1961]: rcvd [LCP EchoRep id=0x3 magic=0x49054e34]
    Aug 19 09:18:22 (none) pppd[1961]: sent [LCP EchoReq id=0x4 magic=0x9659191c]
    Aug 19 09:18:22 (none) pppd[1961]: rcvd [LCP EchoRep id=0x4 magic=0x49054e34]
    Aug 19 09:18:27 (none) pppd[1961]: sent [LCP EchoReq id=0x5 magic=0x9659191c]
    Aug 19 09:18:27 (none) pppd[1961]: rcvd [LCP EchoRep id=0x5 magic=0x49054e34]
    Aug 19 09:18:32 (none) pppd[1961]: sent [LCP EchoReq id=0x6 magic=0x9659191c]
    Aug 19 09:18:32 (none) pppd[1961]: rcvd [LCP EchoRep id=0x6 magic=0x49054e34]
    Aug 19 09:18:37 (none) pppd[1961]: sent [LCP EchoReq id=0x7 magic=0x9659191c]
    Aug 19 09:18:37 (none) pppd[1961]: rcvd [LCP EchoRep id=0x7 magic=0x49054e34]
    Aug 19 09:18:42 (none) pppd[1961]: sent [LCP EchoReq id=0x8 magic=0x9659191c]
    Aug 19 09:18:42 (none) pppd[1961]: rcvd [LCP EchoRep id=0x8 magic=0x49054e34]
    Aug 19 09:18:47 (none) pppd[1961]: sent [LCP EchoReq id=0x9 magic=0x9659191c]
    Aug 19 09:18:47 (none) pppd[1961]: rcvd [LCP EchoRep id=0x9 magic=0x49054e34]
    Aug 19 09:18:52 (none) pppd[1961]: sent [LCP EchoReq id=0xa magic=0x9659191c]
    Aug 19 09:18:52 (none) pppd[1961]: rcvd [LCP EchoRep id=0xa magic=0x49054e34]
    Aug 19 09:18:57 (none) pppd[1961]: sent [LCP EchoReq id=0xb magic=0x9659191c]
    Aug 19 09:18:57 (none) pppd[1961]: rcvd [LCP EchoRep id=0xb magic=0x49054e34]
    Aug 19 09:19:02 (none) pppd[1961]: sent [LCP EchoReq id=0xc magic=0x9659191c]
    Aug 19 09:19:02 (none) pptpd[1949]: CTRL: Received PPTP Control Message (type: 5)
    Aug 19 09:19:02 (none) pptpd[1949]: CTRL: Made a ECHO RPLY packet
    Aug 19 09:19:02 (none) pptpd[1949]: CTRL: I wrote 20 bytes to the client.
    Aug 19 09:19:02 (none) pptpd[1949]: CTRL: Sent packet to client
    Aug 19 09:19:02 (none) pppd[1961]: rcvd [LCP EchoRep id=0xc magic=0x49054e34]
    Aug 19 09:19:07 (none) pppd[1961]: sent [LCP EchoReq id=0xd magic=0x9659191c]
    Aug 19 09:19:07 (none) pppd[1961]: rcvd [LCP EchoRep id=0xd magic=0x49054e34]
    Aug 19 09:19:12 (none) pppd[1961]: sent [LCP EchoReq id=0xe magic=0x9659191c]
    Aug 19 09:19:12 (none) pppd[1961]: rcvd [LCP EchoRep id=0xe magic=0x49054e34]
    …………..

    I hope you will found something. 

    Thanks for you help again.
    Harald  
  • 0 in reply to Helmdach
    Hi Harald,

    as I can see from your log, the RADIUS authentication works fine. However, when the RADIUS accounting message is being sent (ASL -> RADIUS server), things go wrong. Make sure that the accounting service is running on the RADIUS server (UDP port 1813). Also make sure that UDP port 1813 can be reached from the ASL to the RADIUS server.

    Stephan
      
Reply
  • 0 in reply to Helmdach
    Hi Harald,

    as I can see from your log, the RADIUS authentication works fine. However, when the RADIUS accounting message is being sent (ASL -> RADIUS server), things go wrong. Make sure that the accounting service is running on the RADIUS server (UDP port 1813). Also make sure that UDP port 1813 can be reached from the ASL to the RADIUS server.

    Stephan
      
Children
  • 0 in reply to Stephan_Scholz
    Hallo Staphan,

    on Radius Port 1813 is set for accounting.
    I could not found what ist wrong.
    How can i test if the UDP port 1813 can riched from asl?
    The only way i tried :
    from Network - Tools made a TCP Connect to port 1813 of the Radius Server. Here the answer:
    TALLY [192.168.32.1] 1813 (radius-acct) : Connection refused
     sent 0, rcvd 0

    In my oppinion this is correct.
    What else?

    Hope you have any more ideas.
    Harals  
Cookie Information Banner