Guest User!

You are not Sophos Staff.

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

xmit failed

Hello,

Astaro v8 PPTP connection no problem. Astaro v9 PPTP 20-30 trying and connect. 

Bug:
Bad checksum from pppd.
GRE: xmit failed from decaps_hdlc: Operation not permitted
CTRL: PTY read or GRE write failed (pty,gre)=(6,7)

PPTP Log:

2012:11:20-18:39:38 cpfw pptpd[17411]: MGR: Reaped child 19215
2012:11:20-18:39:38 cpfw pptpd[19215]: CTRL: Client yyy.yyy.yyy.yyy control connection finished
2012:11:20-18:39:38 cpfw pptpd[19215]: CTRL: Exiting now
2012:11:20-18:39:39 cpfw pptpd[19217]: MGR: Launching /usr/sbin/pptpctrl to handle client
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: local address = 192.168.1.1
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: remote address = 192.168.1.2
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Client yyy.yyy.yyy.yyy control connection started
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Received PPTP Control Message (type: 1)
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Made a START CTRL CONN RPLY packet
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: I wrote 156 bytes to the client.
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Sent packet to client
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Received PPTP Control Message (type: 7)
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Set parameters to 100000000 maxbps, 64 window size
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Made a OUT CALL RPLY packet
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Starting call (launching pppd, opening GRE)
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: pty_fd = 6
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: tty_fd = 7
2012:11:20-18:39:39 cpfw pptpd[19218]: CTRL (PPPD Launcher): program binary = /usr/sbin/pppd
2012:11:20-18:39:39 cpfw pptpd[19218]: CTRL (PPPD Launcher): local address = 192.168.1.1
2012:11:20-18:39:39 cpfw pptpd[19218]: CTRL (PPPD Launcher): remote address = 192.168.1.2
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: I wrote 32 bytes to the client.
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Sent packet to client
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: Plugin aua.so loaded.
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: AUA plugin initialized.
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: pppd 2.4.5 started by (unknown), uid 0
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: using channel 451
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: Starting negotiation on /dev/ttyp0
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: sent [LCP ConfReq id=0x1        ]
2012:11:20-18:39:39 cpfw pptpd[19217]: GRE: Bad checksum from pppd.
2012:11:20-18:39:39 cpfw pptpd[19217]: GRE: xmit failed from decaps_hdlc: Operation not permitted
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: PTY read or GRE write failed (pty,gre)=(6,7)
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Reaping child PPP[19218]
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: Modem hangup
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: Connection terminated.
2012:11:20-18:39:39 cpfw pppd-pptp[19218]: Exit.
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Client yyy.yyy.yyy.yyy control connection finished
2012:11:20-18:39:39 cpfw pptpd[19217]: CTRL: Exiting now


This thread was automatically locked due to age.
  • Trying, trying... connect succesful:

    PPTP Log:
    2012:11:20-18:39:39 cpfw pptpd[17411]: MGR: Reaped child 19217
    2012:11:20-18:39:40 cpfw pptpd[19219]: MGR: Launching /usr/sbin/pptpctrl to handle client
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: local address = 192.168.1.1
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: remote address = 192.168.1.2
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Client yyy.yyy.yyy.yyy control connection started
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Received PPTP Control Message (type: 1)
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Made a START CTRL CONN RPLY packet
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: I wrote 156 bytes to the client.
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Sent packet to client
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Received PPTP Control Message (type: 7)
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Set parameters to 100000000 maxbps, 64 window size
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Made a OUT CALL RPLY packet
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Starting call (launching pppd, opening GRE)
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: pty_fd = 6
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: tty_fd = 7
    2012:11:20-18:39:40 cpfw pptpd[19220]: CTRL (PPPD Launcher): program binary = /usr/sbin/pppd
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: I wrote 32 bytes to the client.
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Sent packet to client
    2012:11:20-18:39:40 cpfw pptpd[19220]: CTRL (PPPD Launcher): local address = 192.168.1.1
    2012:11:20-18:39:40 cpfw pptpd[19220]: CTRL (PPPD Launcher): remote address = 192.168.1.2
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: Plugin aua.so loaded.
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: AUA plugin initialized.
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: pppd 2.4.5 started by (unknown), uid 0
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: using channel 452
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: Starting negotiation on /dev/ttyp0
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: sent [LCP ConfReq id=0x1        ]
    2012:11:20-18:39:40 cpfw pptpd[19219]: GRE: Bad checksum from pppd.
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Received PPTP Control Message (type: 15)
    2012:11:20-18:39:40 cpfw pptpd[19219]: CTRL: Got a SET LINK INFO packet with standard ACCMs
    2012:11:20-18:39:40 cpfw pptpd[19219]: GRE: accepting packet #0
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: rcvd [LCP ConfReq id=0x0     ]
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: sent [LCP ConfRej id=0x0 ]
    2012:11:20-18:39:40 cpfw pptpd[19219]: GRE: accepting packet #1
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: rcvd [LCP ConfReq id=0x1    ]
    2012:11:20-18:39:40 cpfw pppd-pptp[19220]: sent [LCP ConfAck id=0x1    ]
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: sent [LCP ConfReq id=0x1        ]
    2012:11:20-18:39:43 cpfw pptpd[19219]: GRE: accepting packet #2
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: rcvd [LCP ConfRej id=0x1  ]
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: sent [LCP ConfReq id=0x2      ]
    2012:11:20-18:39:43 cpfw pptpd[19219]: GRE: accepting packet #3
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: rcvd [LCP ConfAck id=0x2      ]
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: sent [LCP EchoReq id=0x0 magic=0xb6f923ce]
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: sent [CHAP Challenge id=0xad , name = "pptp"]
    2012:11:20-18:39:43 cpfw pptpd[19219]: GRE: accepting packet #4
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: rcvd [LCP Ident id=0x2 magic=0x631111f0 "MSRASV5.20"]
    2012:11:20-18:39:43 cpfw pptpd[19219]: CTRL: Received PPTP Control Message (type: 15)
    2012:11:20-18:39:43 cpfw pptpd[19219]: CTRL: Ignored a SET LINK INFO packet with real ACCMs!
    2012:11:20-18:39:43 cpfw pptpd[19219]: GRE: accepting packet #5
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: rcvd [LCP Ident id=0x3 magic=0x631111f0 "MSRAS-0-TUGRABILGISAYAR"]
    2012:11:20-18:39:43 cpfw pptpd[19219]: GRE: accepting packet #6
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: rcvd [LCP Ident id=0x4 magic=0x631111f0 "\017\010\036\37777777706\37777777636\016oG\37777777652u\37777777770\001\37777777766H%\t"]
    2012:11:20-18:39:43 cpfw pptpd[19219]: GRE: accepting packet #7
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: rcvd [LCP EchoRep id=0x0 magic=0x631111f0]
    2012:11:20-18:39:43 cpfw pptpd[19219]: GRE: accepting packet #8
    2012:11:20-18:39:43 cpfw pppd-pptp[19220]: rcvd [CHAP Response id=0xad , name = "vpn7"]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #9
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: AUAconnect - Returned IPAddr *
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: AUA: authentication of user vpn7 succeeded
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [CHAP Success id=0xad "S=0B5E367666687B62746CB331EAD7E348B26A1F4A M=Access granted"]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: Using interface ppp1
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [CCP ConfReq id=0x1 ]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [CHAP Response id=0xad , name = "vpn7"]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [CHAP Success id=0xad "S=0B5E367666687B62746CB331EAD7E348B26A1F4A M=Access granted"]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #10
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [proto=0x8057] 01 05 00 0e 01 0a 40 2b 4d 3f d0 3d 6f d5
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: Unsupported protocol 'IPv6 Control Protovol' (0x8057) received
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [LCP ProtRej id=0x3 80 57 01 05 00 0e 01 0a 40 2b 4d 3f d0 3d 6f d5]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #11
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [CCP ConfReq id=0x6 ]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [CCP ConfNak id=0x6 ]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #12
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [IPCP ConfReq id=0x7     ]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [IPCP TermAck id=0x7]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #13
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [CCP ConfNak id=0x1 ]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [CCP ConfReq id=0x2 ]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #14
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [CCP ConfReq id=0x8 ]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [CCP ConfAck id=0x8 ]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #15
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [CCP ConfAck id=0x2 ]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: MPPE 128-bit stateless compression enabled
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [IPCP ConfReq id=0x1  ]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #16
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [IPCP ConfRej id=0x1 ]
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: sent [IPCP ConfReq id=0x2 ]
    2012:11:20-18:39:45 cpfw pptpd[19219]: GRE: accepting packet #17
    2012:11:20-18:39:45 cpfw pppd-pptp[19220]: rcvd [IPCP ConfAck id=0x2 ]
    2012:11:20-18:39:47 cpfw pptpd[19219]: GRE: accepting packet #18
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: rcvd [IPCP ConfReq id=0x9     ]
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: sent [IPCP ConfRej id=0x9    ]
    2012:11:20-18:39:47 cpfw pptpd[19219]: GRE: accepting packet #19
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: rcvd [IPCP ConfReq id=0xa ]
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: sent [IPCP ConfNak id=0xa ]
    2012:11:20-18:39:47 cpfw pptpd[19219]: GRE: accepting packet #20
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: rcvd [IPCP ConfReq id=0xb ]
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: sent [IPCP ConfAck id=0xb ]
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: found interface eth0 for proxy arp
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: local  IP address 192.168.1.1
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: remote IP address 192.168.1.2
    2012:11:20-18:39:47 cpfw pppd-pptp[19220]: Script /etc/ppp/ip-up started (pid 19224)
    2012:11:20-18:39:47 cpfw pptpd[19219]: GRE: accepting packet #21
    ....


    Thanks.