Guest User!

You are not Sophos Staff.

[8.900][BUG] PPPoA can't connect

After I installed UTM 9 in a VM and restored the config my PPPoA connection stops working.

Error like this showed up in the PPPoA Log:


2012:03:10-00:47:49 asg pppoa-sh: pptpc[5883] pppd: : call REF_RIRiDatVxB ipparam eth1#REF_RIRiDatVxB failed
2012:03:10-00:47:49 asg pppoa-sh: pptpc[5883] pptp: call manager or gre-gateway failed
2012:03:10-00:47:49 asg pppoa-sh: pptpc[5883] one or more processes missing 
2012:03:10-00:47:49 asg pppoa-sh: pptpc[5883] shutting down pptp connection  10.0.0.138
2012:03:10-00:47:54 asg pppoa-sh: pptpc[5883] removing UNIX domain socket /var/run/pptp/10.0.0.138 
2012:03:10-00:47:54 asg pppoa-sh: pptpc[5883] encountered 1 errors so far 
2012:03:10-00:47:54 asg pppoa-sh: pptpc[5883] connection terminated after 15 sec 
2012:03:10-00:47:54 asg pppoa-sh: pptpc[5883] connection terminated prematurely 
2012:03:10-00:47:54 asg pppoa-sh: pptpc[5883] restarting connection in 5 sec 
2012:03:10-00:47:54 asg pppoa-sh: pptpc[5883] 1/3 critical error threshold 
2012:03:10-00:48:24 asg pppoa-sh: pptpc[5883] initiating PPTP connection 
2012:03:10-00:48:24 asg pppoa-sh: pptpc[5883] waiting 10 sec for ip-up script 
2012:03:10-00:48:24 asg pppd-pppoa[6010]: pppd 2.4.6 started by (unknown), uid 0
2012:03:10-00:48:24 asg pppd-pppoa[6010]: Couldn't open pty slave /dev/pts/0: No such file or directory
2012:03:10-00:48:24 asg pppd-pppoa[6010]: using channel 6 
2012:03:10-00:48:24 asg pppd-pppoa[6010]: Using interface ppp0 
2012:03:10-00:48:24 asg pppd-pppoa[6010]: Connect: ppp0  /dev/ttyp0 
2012:03:10-00:48:25 asg pppd-pppoa[6010]: sent [LCP ConfReq id=0x1      ]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: rcvd [LCP ConfReq id=0xb2   ]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: sent [LCP ConfAck id=0xb2   ]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: rcvd [LCP ConfRej id=0x1    ]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: sent [LCP ConfReq id=0x2  ]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: rcvd [LCP ConfAck id=0x2  ]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: sent [LCP EchoReq id=0x0 magic=0x3eaff7c7]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: peer refused to authenticate: terminating link
2012:03:10-00:48:25 asg pppd-pppoa[6010]: sent [LCP TermReq id=0x3 "peer refused to authenticate"]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: rcvd [CHAP Challenge id=0x1 , name = "W-S-PE1909"]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: Discarded non-LCP packet when LCP not open
2012:03:10-00:48:25 asg pppd-pppoa[6010]: rcvd [LCP EchoRep id=0x0 magic=0x4a3649e9]
2012:03:10-00:48:25 asg pppd-pppoa[6010]: rcvd [LCP TermAck id=0x3] 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ...
2012:03:10-00:48:25 asg pppd-pppoa[6010]: Connection terminated. 
2012:03:10-00:48:25 asg pppd-pppoa[6010]: Script /usr/sbin/pptp-current 10.0.0.138 --nolaunchpppd finished (pid 6011), status = 0x0
2012:03:10-00:48:25 asg pppd-pppoa[6010]: Exit. 
2012:03:10-00:48:34 asg pppoa-sh: pptpc[5883] looking for IP info in /var/run/pptp/eth1#REF_RIRiDatVxB 
2012:03:10-00:48:34 asg pppoa-sh: pptpc[5883] /var/run/pptp/eth1#REF_RIRiDatVxB not found, check ip-up script 
2012:03:10-00:48:34 asg pppoa-sh: pptpc[5883] shutting down pptp connection  10.0.0.138
2012:03:10-00:48:39 asg pppoa-sh: pptpc[5883] removing UNIX domain socket /var/run/pptp/10.0.0.138 
2012:03:10-00:48:39 asg pppoa-sh: pptpc[5883] verifying running processes 
2012:03:10-00:48:39 asg pppoa-sh: pptpc[5883] pppd: : call REF_RIRiDatVxB ipparam eth1#REF_RIRiDatVxB failed
2012:03:10-00:48:39 asg pppoa-sh: pptpc[5883] pptp: call manager or gre-gateway failed
2012:03:10-00:48:39 asg pppoa-sh: pptpc[5883] one or more processes missing 
2012:03:10-00:48:39 asg pppoa-sh: pptpc[5883] shutting down pptp connection  10.0.0.138
2012:03:10-00:48:43 asg pppoa-sh: pptpc[5883] removing UNIX domain socket /var/run/pptp/10.0.0.138 
2012:03:10-00:48:43 asg pppoa-sh: pptpc[5883] encountered 2 errors so far 
2012:03:10-00:48:43 asg pppoa-sh: pptpc[5883] connection terminated after 15 sec 
2012:03:10-00:48:43 asg pppoa-sh: pptpc[5883] connection terminated prematurely 
2012:03:10-00:48:43 asg pppoa-sh: pptpc[5883] restarting connection in 5 sec 
2012:03:10-00:48:43 asg pppoa-sh: pptpc[5883] 2/3 critical error threshold 
Regards,
Fred
  • Thanks for spotting this one! Can reproduce this issue here...

    Cheers
     Ulrich
  • Evertime I attend a Astaro Beta, I find the PPPoA Bug!!! [;)]
     
    Cheers
  • Hehe, there are not many PPPoA customers out there [:)]
    Will be fixed in 8.910!
  • Can you post you pppoa log here or send it to uweber@astaro.com?

    Thanks
     Ulrich
  • Hello!

    Log:
    2012:04:05-17:59:21 asg pppoa-sh: pptpc[24612] PPTP over Ethernet Loop Control Script activated 
    2012:04:05-17:59:21 asg pppoa-sh: pptpc[24612] waiting 10 seconds for mdw filter setup 
    2012:04:05-17:59:36 asg pppoa-sh: pptpc[24612] initiating PPTP connection 
    2012:04:05-17:59:36 asg pppoa-sh: pptpc[24612] waiting 10 sec for ip-up script 
    2012:04:05-17:59:36 asg pppd-pppoa[24658]: pppd 2.4.5 started by (unknown), uid 0
    2012:04:05-17:59:36 asg pppd-pppoa[24658]: Couldn't open pty slave /dev/pts/0: No such file or directory
    2012:04:05-17:59:36 asg pppd-pppoa[24658]: using channel 51
    2012:04:05-17:59:36 asg pppd-pppoa[24658]: Using interface ppp0
    2012:04:05-17:59:36 asg pppd-pppoa[24658]: Connect: ppp0  /dev/ttyp0
    2012:04:05-17:59:37 asg pppd-pppoa[24658]: sent [LCP ConfReq id=0x1     ]
    2012:04:05-17:59:40 asg pppd-pppoa[24658]: sent [LCP ConfReq id=0x1     ]
    2012:04:05-17:59:43 asg pppd-pppoa[24658]: sent [LCP ConfReq id=0x1     ]
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] looking for IP info in /var/run/pptp/eth1#REF_IntCabWan 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] /var/run/pptp/eth1#REF_IntCabWan not found, check ip-up script 
    2012:04:05-17:59:46 asg pppd-pppoa[24658]: sent [LCP ConfReq id=0x1     ]
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] shutting down pptp connection  10.0.0.138
    2012:04:05-17:59:46 asg pppd-pppoa[24658]: Terminating on signal 15
    2012:04:05-17:59:46 asg pppd-pppoa[24658]: sent [LCP TermReq id=0x2 "User request"]
    2012:04:05-17:59:46 asg pppd-pppoa[24658]: Child process /usr/sbin/pptp-current 10.0.0.138 --nolaunchpppd (pid 24659) terminated with signal 15
    2012:04:05-17:59:46 asg pppd-pppoa[24658]: Modem hangup
    2012:04:05-17:59:46 asg pppd-pppoa[24658]: Connection terminated.
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] removing UNIX domain socket /var/run/pptp/10.0.0.138 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] verifying running processes 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] pptp: call manager or gre-gateway failed
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] one or more processes missing 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] shutting down pptp connection  10.0.0.138
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] removing UNIX domain socket /var/run/pptp/10.0.0.138 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] encountered 1 errors so far 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] connection terminated after 10 sec 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] connection terminated prematurely 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] restarting connection in 5 sec 
    2012:04:05-17:59:46 asg pppoa-sh: pptpc[24612] 1/3 critical error threshold 
    2012:04:05-17:59:46 asg pppd-pppoa[24658]: Exit.



    Interface-Settings:
    Name: WAN
    Art: DSL (PPPOA/PPTP)
    Standard-GW: yes
    Username: ******
    PW: ******
    Extended Settings:
    Modem-IP: 10.0.0.138
    NIC-Address: 10.0.0.139
    NIC-Netmask: /24
    Ping-Address: 195.3.96.67 (Telekom Austria DNS)
    MTU: 1500
    Daily Reconnect: Yes
    Asymmetric: Yes


    EDIT:
    I got this issue also in version 8.301
  • Hi bennex,

    at least its not a regression in v9 [;)]

    Can you check to reach the modem via command line,
    e.g. ping 10.0.0.138

    You are sure this is PPPoA and not PPPoE or Cable?

    Cheers
     Ulrich
  • Hi bennex,

    at least its not a regression in v9 [;)]

    Can you check to reach the modem via command line,
    e.g. ping 10.0.0.138

    You are sure this is PPPoA and not PPPoE or Cable?

    Cheers
     Ulrich


    Hello!

    When i connect to the Modem with Windows 7 PPTP Client it works. I got a 2 new logfiles for you:

    PPPOA LOG:
    2012:04:10-18:12:12 asg pppoa-sh: pptpc[10509] initiating PPTP connection 
    
    2012:04:10-18:12:12 asg pppoa-sh: pptpc[10509] waiting 10 sec for ip-up script 
    2012:04:10-18:12:12 asg pppd-pppoa[12173]: pppd 2.4.5 started by (unknown), uid 0
    2012:04:10-18:12:12 asg pppd-pppoa[12173]: Couldn't open pty slave /dev/pts/0: No such file or directory
    2012:04:10-18:12:12 asg pppd-pppoa[12173]: using channel 16
    2012:04:10-18:12:12 asg pppd-pppoa[12173]: Using interface ppp0
    2012:04:10-18:12:12 asg pppd-pppoa[12173]: Connect: ppp0  /dev/ttyp0
    2012:04:10-18:12:13 asg pppd-pppoa[12173]: sent [LCP ConfReq id=0x1    ]
    2012:04:10-18:12:15 asg pppd-pppoa[12173]: Script /usr/sbin/pptp-current 10.0.0.139 --nolaunchpppd finished (pid 12174), status = 0x1
    2012:04:10-18:12:15 asg pppd-pppoa[12173]: Modem hangup
    2012:04:10-18:12:15 asg pppd-pppoa[12173]: Connection terminated.
    2012:04:10-18:12:16 asg pppd-pppoa[12173]: Exit.
    2012:04:10-18:12:22 asg pppoa-sh: pptpc[10509] looking for IP info in /var/run/pptp/eth1#REF_IntPppExternal 
    2012:04:10-18:12:22 asg pppoa-sh: pptpc[10509] /var/run/pptp/eth1#REF_IntPppExternal not found, check ip-up script 
    2012:04:10-18:12:22 asg pppoa-sh: pptpc[10509] shutting down pptp connection  10.0.0.139
    2012:04:10-18:12:27 asg pppoa-sh: pptpc[10509] removing UNIX domain socket /var/run/pptp/10.0.0.139 
    2012:04:10-18:12:27 asg pppoa-sh: pptpc[10509] verifying running processes 
    2012:04:10-18:12:27 asg pppoa-sh: pptpc[10509] pppd: : call REF_IntPppExternal ipparam eth1#REF_IntPppExternal failed
    2012:04:10-18:12:27 asg pppoa-sh: pptpc[10509] pptp: call manager or gre-gateway failed
    2012:04:10-18:12:27 asg pppoa-sh: pptpc[10509] one or more processes missing 
    2012:04:10-18:12:27 asg pppoa-sh: pptpc[10509] shutting down pptp connection  10.0.0.139
    2012:04:10-18:12:32 asg pppoa-sh: pptpc[10509] removing UNIX domain socket /var/run/pptp/10.0.0.139 
    2012:04:10-18:12:32 asg pppoa-sh: pptpc[10509] encountered 10 errors so far 
    2012:04:10-18:12:33 asg pppoa-sh: pptpc[10509] connection terminated after 15 sec 
    2012:04:10-18:12:33 asg pppoa-sh: pptpc[10509] connection terminated prematurely 
    2012:04:10-18:12:33 asg pppoa-sh: pptpc[10509] restarting connection in 5 sec  


    Fallback-Messanger Log:
    2012:04:10-18:15:36 asg [daemon:warning] pptp[12634]:  anon warn[open_inetsock[:P]ptp_callmgr.c:329]: connect: No route to host
    
    2012:04:10-18:15:36 asg [daemon:crit] pptp[12634]:  anon fatal[callmgr_main[:P]ptp_callmgr.c:127]: Could not open control connection to 10.0.0.139
    2012:04:10-18:15:36 asg [daemon:crit] pptp[12632]:  anon fatal[open_callmgr[:P]ptp.c:479]: Call manager exited with error 256
  • Did you mixed up Modem IP and Interface IP?
    Default Modem IP is 10.0.0.138 while default NIC IP is 10.0.0.140.

    In above log however an control connection to 10.0.0.139 is tried.

    Cheers
     Ulrich
  • Hello!

    I changed the Default Modem IP to 10.0.0.139.
Share Feedback
×

Submitted a Tech Support Case lately from the Support Portal?