[Solved] PPPoE Client: Cannot connect, PADO with unknown host-uniq, dropping

Hi,

I am trying to setup a PPPoE client connection to my ISP over a VDSL line. My router is a RB3011UiAS connected to a Draytek Vigor V130 running in bridged mode. The V130 is synchronized with the other endpoint and does show me a running VDSL line on the physical layer. When I setup the PPPoE connection to the ISP I am using the parameters as suggested by them. The connection seems to be established for about a second and then its gone again…

The log entry look as follows:

21:48:20 pppoe,ppp,debug PPPoE-Inexio: LCP opened 
21:48:20 pppoe,ppp,info PPPoE-Inexio: authenticated 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: IPCP lowerup 
21:48:20 pppoe,ppp,debug,packet  PPPoE-Inexio: sent IPCP ConfReq id=0xf1 
21:48:20 pppoe,ppp,debug,packet     <addr 0.0.0.0> 
21:48:20 pppoe,ppp,debug,packet     <ms-dns 0.0.0.0> 
21:48:20 pppoe,ppp,debug,packet     <ms-dns 0.0.0.0> 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: IPCP open 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: IPV6CP open 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: MPLSCP lowerup 
21:48:20 pppoe,ppp,debug,packet  PPPoE-Inexio: sent MPLSCP ConfReq id=0xf1 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: MPLSCP open 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: BCP open 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: CCP lowerup 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: CCP open 
21:48:20 pppoe,ppp,debug,packet  PPPoE-Inexio: rcvd LCP TermReq id=0xa3 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: LCP closed 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: CCP lowerdown 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: BCP lowerdown 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: BCP down event in starting state 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: IPCP lowerdown 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: IPV6CP lowerdown 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: IPV6CP down event in starting state 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: MPLSCP lowerdown 
21:48:20 pppoe,ppp,debug,packet  PPPoE-Inexio: sent LCP TermAck id=0xa3 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: LCP lowerdown 
21:48:20 pppoe,ppp,info PPPoE-Inexio: terminating... 
21:48:20 pppoe,debug,packet ether6: sent PADT to 00:00:00:00:00:00 
21:48:20 pppoe,debug,packet     session-id=0x16e5 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: LCP lowerdown 
21:48:20 pppoe,ppp,debug PPPoE-Inexio: LCP down event in starting state 
21:48:20 pppoe,ppp,info PPPoE-Inexio: disconnected 
21:48:20 pppoe,debug,packet ether6: rcvd PADT from F0:1C:2D:2A:1F:EF 
21:48:20 pppoe,debug,packet     session-id=0x16e5 
21:48:22 pppoe,debug,packet ether6: rcvd PADO from F0:1C:2D:2A:9F:EF 
21:48:22 pppoe,debug,packet     session-id=0x0000 
21:48:22 pppoe,debug,packet     ac-name=ix-r4.einsiedlerhof 
21:48:22 pppoe,debug,packet     host-uniq=0x2003c000 
21:48:22 pppoe,debug,packet     service-name= 
21:48:22 pppoe,debug,packet     ac-cookie=5c ee 71 73 6d 38 70 33 02 b8 36 9f 7c 31 20 9f 
21:48:22 pppoe,debug ether6: received PADO with unknown host-uniq, dropping 
21:48:23 pppoe,ppp,info PPPoE-Inexio: initializing... 
21:48:23 pppoe,ppp,info PPPoE-Inexio: connecting... 
21:48:23 pppoe,debug,packet ether6: sent PADI to FF:FF:FF:FF:FF:FF 
21:48:23 pppoe,debug,packet     session-id=0x0000 
21:48:23 pppoe,debug,packet     host-uniq=0x2203c000 
21:48:23 pppoe,debug,packet     service-name= 
21:48:23 pppoe,debug,packet ether6: rcvd PADO from F0:1C:2D:2A:1F:EF 
21:48:23 pppoe,debug,packet     session-id=0x0000 
21:48:23 pppoe,debug,packet     ac-name=ix-r4.ffm 
21:48:23 pppoe,debug,packet     host-uniq=0x2203c000 
21:48:23 pppoe,debug,packet     service-name= 
21:48:23 pppoe,debug,packet     ac-cookie=5c ee 71 73 6d 38 70 33 02 b8 36 9f 7c 31 20 9f 
21:48:23 pppoe,debug,packet ether6: sent PADR to F0:1C:2D:2A:1F:EF 
21:48:23 pppoe,debug,packet     session-id=0x0000 
21:48:23 pppoe,debug,packet     host-uniq=0x2303c000 
21:48:23 pppoe,debug,packet     service-name= 
21:48:23 pppoe,debug,packet     ac-cookie=5c ee 71 73 6d 38 70 33 02 b8 36 9f 7c 31 20 9f 
21:48:23 pppoe,debug,packet ether6: rcvd PADS from F0:1C:2D:2A:1F:EF 
21:48:23 pppoe,debug,packet     session-id=0x16e5 
21:48:23 pppoe,debug,packet     service-name= 
21:48:23 pppoe,debug,packet     host-uniq=0x2303c000 
21:48:23 pppoe,debug,packet     ac-name=ix-r4.ffm 
21:48:23 pppoe,debug,packet     ac-cookie=5c ee 71 73 6d 38 70 33 02 b8 36 9f 7c 31 20 9f 
21:48:23 pppoe,ppp,debug PPPoE-Inexio: LCP lowerup 
21:48:23 pppoe,ppp,debug PPPoE-Inexio: LCP open 
21:48:23 pppoe,ppp,debug PPPoE-Inexio: LCP timer 
21:48:23 pppoe,ppp,debug,packet  PPPoE-Inexio: sent LCP ConfReq id=0x6 
21:48:23 pppoe,ppp,debug,packet    <mru 1480> 
21:48:23 pppoe,ppp,debug,packet    <magic 0x749e283b> 
21:48:23 pppoe,ppp,debug,packet  PPPoE-Inexio: rcvd LCP ConfReq id=0xad 
21:48:23 pppoe,ppp,debug,packet    <mru 1492> 
21:48:23 pppoe,ppp,debug,packet    <magic 0x6114564> 
21:48:23 pppoe,ppp,debug,packet    <auth pap> 
21:48:23 pppoe,ppp,debug,packet  PPPoE-Inexio: sent LCP ConfRej id=0xad 
21:48:23 pppoe,ppp,debug,packet    <auth pap> 
21:48:23 pppoe,ppp,debug,packet  PPPoE-Inexio: rcvd LCP ConfAck id=0x6 
21:48:23 pppoe,ppp,debug,packet    <mru 1480> 
21:48:23 pppoe,ppp,debug,packet    <magic 0x749e283b> 
21:48:24 pppoe,ppp,debug,packet  PPPoE-Inexio: rcvd LCP ConfReq id=0xae 
21:48:24 pppoe,ppp,debug,packet    <mru 1492> 
21:48:24 pppoe,ppp,debug,packet    <magic 0x6114564> 
21:48:24 pppoe,ppp,debug,packet  PPPoE-Inexio: sent LCP ConfAck id=0xae 
21:48:24 pppoe,ppp,debug,packet    <mru 1492> 
21:48:24 pppoe,ppp,debug,packet    <magic 0x6114564> 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: LCP opened 
21:48:24 pppoe,ppp,info PPPoE-Inexio: authenticated 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: IPCP lowerup 
21:48:24 pppoe,ppp,debug,packet  PPPoE-Inexio: sent IPCP ConfReq id=0xf2 
21:48:24 pppoe,ppp,debug,packet     <addr 0.0.0.0> 
21:48:24 pppoe,ppp,debug,packet     <ms-dns 0.0.0.0> 
21:48:24 pppoe,ppp,debug,packet     <ms-dns 0.0.0.0> 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: IPCP open 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: IPV6CP open 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: MPLSCP lowerup 
21:48:24 pppoe,ppp,debug,packet  PPPoE-Inexio: sent MPLSCP ConfReq id=0xf2 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: MPLSCP open 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: BCP open 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: CCP lowerup 
21:48:24 pppoe,ppp,debug PPPoE-Inexio: CCP open

I think the problem is the entry "2 pppoe,debug ether6: received PADO with unknown host-uniq, dropping ". Something is going wrong here. Does anybody have suggestions? I googled a lot and some users are reporting similar problems with their Mikrotik system…

Thanks for the help!
Regards
Toby

After upgrading to 6.37 rc27 and enabling pap authentication it works…