I've had this device up and running for a few days and have struggled to maintain a stable PPPoE connection. Every hour or so (sometimes every few minutes) the WAN connection drops and I get Modem Hangup in the logs. My ISP is BT in the UK on their Fibre 900 (900 down/100 up). I have tried the release candidate version, various snapshot versions and experience the same issue. I am currently running SNAPSHOT r19617-4a8eaa5c7c. I have tried both with and without software and hardware flow offloading as I have read this may be related. I'm wondering if these issues are at all related to those mentioned by xabolcs.
Logs:
Tue May 10 09:46:30 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:46:50 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:47:10 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:47:30 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:47:50 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:47:58 2022 daemon.notice pppd[2969]: Modem hangup
Tue May 10 09:47:58 2022 daemon.info pppd[2969]: Connect time 3.2 minutes.
Tue May 10 09:47:58 2022 daemon.info pppd[2969]: Sent 2670477263 bytes, received 221568772 bytes.
Tue May 10 09:47:58 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:47:58 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:47:58 2022 daemon.err odhcp6c[3023]: Failed to send RS (Network unreachable)
Tue May 10 09:47:58 2022 daemon.err odhcp6c[3023]: Failed to send RELEASE message to ff02::1:2 (Network unreachable)
Tue May 10 09:47:58 2022 daemon.notice netifd: Network device 'pppoe-wan' link is down
Tue May 10 09:47:58 2022 daemon.notice netifd: Network alias 'pppoe-wan' link is down
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan6' has link connectivity loss
Tue May 10 09:47:58 2022 daemon.notice pppd[2969]: Connection terminated.
Tue May 10 09:47:58 2022 daemon.info pppd[2969]: Connect time 3.2 minutes.
Tue May 10 09:47:58 2022 daemon.info pppd[2969]: Sent 2670477263 bytes, received 221568772 bytes.
Tue May 10 09:47:58 2022 daemon.notice netifd: wan6 (3023): Command failed: ubus call network.interface notify_proto { "action": 0, "link-up": false, "keep": false, "interface": "wan6" } (Permission denied)
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' has lost the connection
Tue May 10 09:47:58 2022 daemon.warn dnsmasq[1]: no servers found in /tmp/resolv.conf.d/resolv.conf.auto, will retry
Tue May 10 09:47:58 2022 daemon.info pppd[2969]: Exit.
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' is now down
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' is disabled
Tue May 10 09:47:58 2022 kern.info kernel: [ 526.250425] mt7530 mdio-bus:00 wan: Link is Down
Tue May 10 09:47:58 2022 kern.info kernel: [ 526.260029] mt7530 mdio-bus:00 wan: configuring for phy/gmii link mode
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' is enabled
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' is setting up now
Tue May 10 09:47:58 2022 daemon.notice netifd: Network device 'wan' link is down
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' has link connectivity loss
Tue May 10 09:47:58 2022 daemon.err insmod: module is already loaded - slhc
Tue May 10 09:47:58 2022 daemon.err insmod: module is already loaded - ppp_generic
Tue May 10 09:47:58 2022 daemon.err insmod: module is already loaded - pppox
Tue May 10 09:47:58 2022 daemon.err insmod: module is already loaded - pppoe
Tue May 10 09:47:58 2022 daemon.notice netifd: wan (3345): Command failed: ubus call network.interface notify_proto { "action": 1, "command": [ "\/usr\/sbin\/pppd", "nodetach", "ipparam", "wan", "ifname", "pppoe-wan", "lcp-echo-interval", "1", "lcp-echo-failure", "5", "lcp-echo-adaptive", "+ipv6", "nodefaultroute", "usepeerdns", "maxfail", "1", "user", "bthomehub@btinternet.com", "password", "bt", "ip-up-script", "\/lib\/netifd\/ppp-up", "ipv6-up-script", "\/lib\/netifd\/ppp6-up", "ip-down-script", "\/lib\/netifd\/ppp-down", "ipv6-down-script", "\/lib\/netifd\/ppp-down", "mtu", "1492", "mru", "1492", "plugin", "pppoe.so", "nic-wan" ], "interface": "wan" } (Permission denied)
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' is now down
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' is disabled
Tue May 10 09:47:58 2022 daemon.notice netifd: Interface 'wan' is enabled
Tue May 10 09:47:58 2022 kern.info kernel: [ 526.341806] mt7530 mdio-bus:00 wan: configuring for phy/gmii link mode
Tue May 10 09:47:59 2022 daemon.err odhcp6c[3023]: Failed to send SOLICIT message to ff02::1:2 (Network unreachable)
Tue May 10 09:47:59 2022 daemon.notice netifd: Interface 'wan6' is now down
Tue May 10 09:47:59 2022 daemon.notice netifd: Interface 'wan6' is disabled
Tue May 10 09:48:02 2022 daemon.notice netifd: Network device 'wan' link is up
Tue May 10 09:48:02 2022 daemon.notice netifd: Interface 'wan' has link connectivity
Tue May 10 09:48:02 2022 daemon.notice netifd: Interface 'wan' is setting up now
Tue May 10 09:48:02 2022 kern.info kernel: [ 529.953705] mt7530 mdio-bus:00 wan: Link is Up - 1Gbps/Full - flow control off
Tue May 10 09:48:02 2022 kern.info kernel: [ 529.960993] IPv6: ADDRCONF(NETDEV_CHANGE): wan: link becomes ready
Tue May 10 09:48:02 2022 daemon.err insmod: module is already loaded - slhc
Tue May 10 09:48:02 2022 daemon.err insmod: module is already loaded - ppp_generic
Tue May 10 09:48:02 2022 daemon.err insmod: module is already loaded - pppox
Tue May 10 09:48:02 2022 daemon.err insmod: module is already loaded - pppoe
Tue May 10 09:48:02 2022 daemon.info pppd[3446]: Plugin pppoe.so loaded.
Tue May 10 09:48:02 2022 daemon.info pppd[3446]: PPPoE plugin from pppd 2.4.9
Tue May 10 09:48:02 2022 daemon.notice pppd[3446]: pppd 2.4.9 started by root, uid 0
Tue May 10 09:48:02 2022 daemon.info pppd[3446]: PPP session is 4675
Tue May 10 09:48:02 2022 daemon.warn pppd[3446]: Connected to f8:13:08:40:c8:96 via interface wan
Tue May 10 09:48:02 2022 kern.info kernel: [ 530.211458] pppoe-wan: renamed from ppp0
Tue May 10 09:48:02 2022 daemon.info pppd[3446]: Renamed interface ppp0 to pppoe-wan
Tue May 10 09:48:02 2022 daemon.info pppd[3446]: Using interface pppoe-wan
Tue May 10 09:48:02 2022 daemon.notice pppd[3446]: Connect: pppoe-wan <--> wan
Tue May 10 09:48:05 2022 daemon.info pppd[3446]: CHAP authentication succeeded: CHAP authentication success
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: CHAP authentication succeeded
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: peer from calling number F8:13:08:40:C8:96 authorized
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: local LL address REDACTED
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: remote LL address REDACTED
Tue May 10 09:48:05 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:05 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: local IP address REDACTED
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: remote IP address REDACTED
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: primary DNS address 81.139.56.100
Tue May 10 09:48:05 2022 daemon.notice pppd[3446]: secondary DNS address 81.139.57.100
Tue May 10 09:48:05 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:05 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:05 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:05 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:05 2022 daemon.notice netifd: Network device 'pppoe-wan' link is up
Tue May 10 09:48:05 2022 daemon.notice netifd: Interface 'wan6' is enabled
Tue May 10 09:48:05 2022 daemon.notice netifd: Network alias 'pppoe-wan' link is up
Tue May 10 09:48:05 2022 daemon.notice netifd: Interface 'wan6' has link connectivity
Tue May 10 09:48:05 2022 daemon.notice netifd: Interface 'wan6' is setting up now
Tue May 10 09:48:05 2022 daemon.notice netifd: Interface 'wan' is now up
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: reading /tmp/resolv.conf.d/resolv.conf.auto
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using nameserver 81.139.56.100#53
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using nameserver 81.139.57.100#53
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using only locally-known addresses for test
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using only locally-known addresses for onion
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using only locally-known addresses for localhost
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using only locally-known addresses for local
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using only locally-known addresses for invalid
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using only locally-known addresses for bind
Tue May 10 09:48:05 2022 daemon.info dnsmasq[1]: using only locally-known addresses for lan
Tue May 10 09:48:05 2022 user.notice firewall: Reloading firewall due to ifup of wan (pppoe-wan)
Tue May 10 09:48:05 2022 user.notice firewall: Reloading firewall due to ifupdate of wan (pppoe-wan)
Tue May 10 09:48:10 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:10 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:10 2022 daemon.notice netifd: Interface 'wan6' is now up
Tue May 10 09:48:10 2022 user.notice firewall: Reloading firewall due to ifup of wan6 (pppoe-wan)
Tue May 10 09:48:10 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:48:12 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:12 2022 daemon.warn dnsmasq[1]: failed to create listening socket for REDACTED%pppoe-wan: Address not available
Tue May 10 09:48:30 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:48:50 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:49:10 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID
Tue May 10 09:49:30 2022 daemon.info dnsmasq-dhcp[1]: DHCPNAK(br-lan) 0.0.0.0 00:46:a8:02:12:18 wrong server-ID