PPPoE configuration issue - help requested

rbubley · January 27, 2024, 6:29pm

I am trying to configure my OpenWRT 23.05.02 router to use an external VDSL modem (Draytek Vigor 130). I've read all of the documents I can google on the subject, but something is still not right.

I have the modem configured in bridge mode with VLAN tagging (so the router does not need to do the VLAN tagging).

I can connect straightforwardly with PPPoE when I plug it into my Mac, yet with my OpenWRT router, the connection fails part-way through.

With OpenWRT:

Sat Jan 27 17:25:24 2024 daemon.info pppd[3406]: Plugin pppoe.so loaded.
Sat Jan 27 17:25:24 2024 daemon.info pppd[3406]: PPPoE plugin from pppd 2.4.9
Sat Jan 27 17:25:24 2024 daemon.notice pppd[3406]: pppd 2.4.9 started by root, uid 0
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]: Send PPPOE Discovery V1T1 PADI session 0x0 length 12
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  dst ff:ff:ff:ff:ff:ff  src REDACTED
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  [service-name] [host-uniq  00 00 0d 4e]
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]: Recv PPPOE Discovery V1T1 PADO session 0x0 length 50
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  dst REDACTED  src REDACTED
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  [service-name] [AC-name acc-aln1.l-tud] [host-uniq  00 00 0d 4e] [AC-cookie  REDACTED]
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]: Send PPPOE Discovery V1T1 PADR session 0x0 length 32
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  dst REDACTED  src REDACTED
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  [service-name] [host-uniq  00 00 0d 4e] [AC-cookie  d5 74 4e fe b0 b9 b9 d5 d8 03 78 72 2a 90 b5 e0]
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]: Recv PPPOE Discovery V1T1 PADO session 0x0 length 50
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  dst REDACTED  src REDACTED
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  [service-name] [AC-name acc-aln1.l-tud] [host-uniq  00 00 0d 4e] [AC-cookie  REDACTED]
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]: Recv PPPOE Discovery V1T1 PADS session 0x1184 length 12
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  dst REDACTED  src REDACTED
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]:  [service-name] [host-uniq  00 00 0d 4e]
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]: PADS: Service-Name: ''
Sat Jan 27 17:25:24 2024 daemon.info pppd[3406]: PPP session is 4484
Sat Jan 27 17:25:24 2024 daemon.warn pppd[3406]: Connected to REDACTED via interface wan
Sat Jan 27 17:25:24 2024 daemon.debug pppd[3406]: using channel 190
Sat Jan 27 17:25:25 2024 daemon.info pppd[3406]: Renamed interface ppp0 to pppoe-wan2
Sat Jan 27 17:25:25 2024 daemon.info pppd[3406]: Using interface pppoe-wan2
Sat Jan 27 17:25:25 2024 daemon.notice pppd[3406]: Connect: pppoe-wan2 <--> wan
Sat Jan 27 17:25:25 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:28 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:31 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:34 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:37 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:40 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:43 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:46 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:49 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:52 2024 daemon.debug pppd[3406]: sent [LCP ConfReq id=0x1 <mru 1492> <magic 0x774fb965>]
Sat Jan 27 17:25:55 2024 daemon.warn pppd[3406]: LCP: timeout sending Config-Requests
Sat Jan 27 17:25:55 2024 daemon.notice pppd[3406]: Connection terminated.
Sat Jan 27 17:25:55 2024 daemon.notice pppd[3406]: Modem hangup
Sat Jan 27 17:25:55 2024 daemon.info pppd[3406]: Exit.

Direct from computer:

Sat Jan 27 16:15:28 2024 : publish_entry SCDSet() failed: Success!
Sat Jan 27 16:15:28 2024 : PPPoE connecting to service '' [access concentrator '']...
Sat Jan 27 16:15:28 2024 : PPPoE connection established.
Sat Jan 27 16:15:28 2024 : using link 0
Sat Jan 27 16:15:28 2024 : Using interface ppp0
Sat Jan 27 16:15:28 2024 : Connect: ppp0 <--> socket[34:16]
Sat Jan 27 16:15:28 2024 : sent [LCP ConfReq id=0x1 <mru 1492> <magic 0xf49259e>]
Sat Jan 27 16:15:28 2024 : rcvd [LCP ConfReq id=0x5f <mru 1492> <auth chap MD5> <magic 0x27eaa3d4>]
Sat Jan 27 16:15:28 2024 : lcp_reqci: returning CONFACK.
Sat Jan 27 16:15:28 2024 : sent [LCP ConfAck id=0x5f <mru 1492> <auth chap MD5> <magic 0x27eaa3d4>]
Sat Jan 27 16:15:28 2024 : rcvd [LCP ConfAck id=0x1 <mru 1492> <magic 0xf49259e>]
Sat Jan 27 16:15:28 2024 : sent [LCP EchoReq id=0x0 magic=0xf49259e]
Sat Jan 27 16:15:28 2024 : rcvd [CHAP Challenge id=0x1 <920a8525c0dd2c70b2a999cfabab202b7fb2d9d2bbd84b49367b824f6f5b1e81e423a6a501521633fb2f04a8daa353d9572d2c9285775bbc73dd8b62b829e4>, name = "acc-aln1.l-tud"]
Sat Jan 27 16:15:28 2024 : sent [CHAP Response id=0x1 <REDACTED1>, name = "REDACTED"]
Sat Jan 27 16:15:28 2024 : rcvd [LCP EchoRep id=0x0 magic=0x27eaa3d4]
Sat Jan 27 16:15:28 2024 : rcvd [LCP ConfReq id=0x1a <auth chap MD5> <magic 0x1c2dd098>]
Sat Jan 27 16:15:28 2024 : sent [LCP ConfReq id=0x2 <mru 1492> <magic 0x2cfc6f59>]
Sat Jan 27 16:15:28 2024 : lcp_reqci: returning CONFACK.
Sat Jan 27 16:15:28 2024 : sent [LCP ConfAck id=0x1a <auth chap MD5> <magic 0x1c2dd098>]
Sat Jan 27 16:15:28 2024 : rcvd [LCP ConfAck id=0x2 <mru 1492> <magic 0x2cfc6f59>]
Sat Jan 27 16:15:28 2024 : sent [LCP EchoReq id=0x0 magic=0x2cfc6f59]
Sat Jan 27 16:15:28 2024 : rcvd [CHAP Challenge id=0xb0 <902f59a5d94636133563b1df5b17148ec673acb86f21dae0bac45e6aaea0881a>, name = "JUNOS"]
Sat Jan 27 16:15:28 2024 : sent [CHAP Response id=0xb0 <REDACTED>, name = "REDACTED"]
Sat Jan 27 16:15:28 2024 : rcvd [LCP EchoRep id=0x0 magic=0x1c2dd098]
Sat Jan 27 16:15:28 2024 : rcvd [CHAP Success id=0xb0 ""]
Sat Jan 27 16:15:28 2024 : CHAP authentication succeeded
Sat Jan 27 16:15:28 2024 : sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Sat Jan 27 16:15:28 2024 : sent [IPV6CP ConfReq id=0x1 <addr REDACTED>]
Sat Jan 27 16:15:28 2024 : rcvd [LCP ProtRej id=0x1b REDACTED]
Sat Jan 27 16:15:28 2024 : rcvd [IPCP ConfReq id=0x1 <addr REDACTED>]
Sat Jan 27 16:15:28 2024 : ipcp: returning Configure-ACK
Sat Jan 27 16:15:28 2024 : sent [IPCP ConfAck id=0x1 <addr REDACTED>]
Sat Jan 27 16:15:28 2024 : rcvd [IPCP ConfNak id=0x1 <addr REDACTED> <ms-dns1 REDACTED> <ms-dns3 REDACTED>]
Sat Jan 27 16:15:28 2024 : sent [IPCP ConfReq id=0x2 <addr REDACTED> <ms-dns1 REDACTED> <ms-dns3 REDACTED>]
Sat Jan 27 16:15:28 2024 : rcvd [IPCP ConfAck id=0x2 <addr REDACTED> <ms-dns1 REDACTED> <ms-dns3 REDACTED>]
Sat Jan 27 16:15:28 2024 : ipcp: up
Sat Jan 27 16:15:28 2024 : local  IP address REDACTED
Sat Jan 27 16:15:28 2024 : remote IP address REDACTED
Sat Jan 27 16:15:28 2024 : primary   DNS address REDACTED
Sat Jan 27 16:15:28 2024 : secondary DNS address REDACTED
Sat Jan 27 16:15:28 2024 : Received protocol dictionaries
Sat Jan 27 16:15:28 2024 : Committed PPP store

What I think is the key part of the DSA network configuration:

config interface 'wan2'
	option device 'wan'
	option proto 'pppoe'
	option username 'REDACTED'
	option password 'REDACTED'
	option ipv6 '0'
	option force_link '1'
	option keepalive '5 1'
	option peerdns '0'
	option delegate '0'

Clearly the PPP communication starts, but then after a certain point it seems that the router is not receiving responses that allow it to proceed with authentication.

Any ideas?

murraydr44 · January 27, 2024, 10:56pm

option device 'wan.35' might help .

Shloimy · January 28, 2024, 12:31am

Seems exactly like the issue I just had. Try increasing the timeout as explained here New to OpenWRT, Need help configuring PPPoE - #8 by bill888

slh · January 28, 2024, 1:18am

If you do want your router to do the VLAN tagging (and not the vigor), see Configuration Issues OpenWRT 19.07.3 and DrayTek Vigor 130 - #4 by slh.

rbubley · February 24, 2024, 2:36pm

So I finally got around to looking at this again, with the intention of trying all of the helpful suggestions above. (Thank you @murraydr44 , @Shloimy , @slh )

Instead what I found is that it just worked -- with no configuration changes at all. I can only presume that somehow in the intervening weeks, between the router and the modem, something happened (maybe a reboot), that fixed it.

system · March 5, 2024, 2:38pm

This topic was automatically closed 10 days after the last reply. New replies are no longer allowed.