Hi. I have been using openwrt for years and recently upgraded from 18.06 to 19.07 and realized that DHCPv6 seems not working properly.
So decided to investigate and need your help.
Hardware: wzr-hp-ag300h.
Configuration:
/etc/config/network
config interface 'loopback'
option ifname 'lo'
option proto 'static'
option ipaddr '127.0.0.1'
option netmask '255.0.0.0'
config globals 'globals'
option ula_prefix 'fda2:e36f:d923::/48'
config interface 'lan'
option type 'bridge'
option ifname 'eth0.1'
option proto 'static'
option netmask '255.255.255.0'
option ip6assign '60'
option ipaddr '192.168.2.254'
config interface 'wan'
option ifname 'eth1'
option proto 'dhcp'
config interface 'wan6'
option ifname 'eth1'
option proto 'dhcpv6'
/etc/config/dhcp
config dnsmasq
option domainneeded '1'
option localise_queries '1'
option rebind_protection '1'
option rebind_localhost '1'
option local '/lan/'
option domain 'lan'
option expandhosts '1'
option authoritative '1'
option readethers '1'
option leasefile '/tmp/dhcp.leases'
option resolvfile '/tmp/resolv.conf.auto'
option nonwildcard '1'
option localservice '1'
config dhcp 'lan'
option interface 'lan'
option leasetime '12h'
option dhcpv6 'server'
option ra 'server'
option start '1'
option limit '64'
option ra_management '1'
config dhcp 'wan'
option interface 'wan'
option ignore '1'
config odhcpd 'odhcpd'
option maindhcp '0'
option leasefile '/tmp/hosts/odhcpd'
option leasetrigger '/usr/sbin/odhcpd-update'
option loglevel '7'
With this same configuration and hardware, I have checked the logread result for both 18.06.7 and 19.07.2.
Here is the results (I have filtered only odhcpd related lines)
From 18.06.7
Sat Feb 29 12:15:09 2020 user.notice ucitrack: Setting up /etc/config/dhcp reload dependency on /etc/config/odhcpd
Sat Feb 29 12:15:12 2020 daemon.info odhcpd[945]: Using a RA lifetime of 0 seconds on br-lan
Sat Feb 29 12:15:12 2020 daemon.notice odhcpd[945]: Failed to send to ff02::1%br-lan (Address not available)
Sat Feb 29 12:15:13 2020 daemon.debug odhcpd[945]: Netlink newaddr fda2:e36f:d923::1%br-lan
Sat Feb 29 12:15:17 2020 daemon.info odhcpd[945]: Using a RA lifetime of 0 seconds on br-lan
Sat Feb 29 12:15:17 2020 daemon.debug odhcpd[945]: Sent 120 bytes to ff02::1%br-lan
Sat Feb 29 12:15:17 2020 daemon.debug odhcpd[945]: Received 127 Bytes from fe80::b196:dccf:ba12:c837%br-lan
Sat Feb 29 12:15:17 2020 daemon.notice odhcpd[945]: Got DHCPv6 request
Sat Feb 29 12:15:17 2020 daemon.warn odhcpd[945]: DHCPV6 CONFIRM IA_NA from 00046f6d78530d9497fef9b5e0e6726f8521 on br-lan: not on-link fda2:e36f:d923::2/128
Sat Feb 29 12:15:17 2020 daemon.debug odhcpd[945]: Sent 96 bytes to fe80::b196:dccf:ba12:c837%br-lan
Sat Feb 29 12:15:17 2020 daemon.info dnsmasq[1396]: read /tmp/hosts/odhcpd - 0 addresses
Sat Feb 29 12:15:17 2020 daemon.debug odhcpd[945]: Received 71 Bytes from fe80::b196:dccf:ba12:c837%br-lan
Sat Feb 29 12:15:17 2020 daemon.notice odhcpd[945]: Got DHCPv6 request
Sat Feb 29 12:15:17 2020 daemon.warn odhcpd[945]: DHCPV6 SOLICIT IA_NA from 00046f6d78530d9497fef9b5e0e6726f8521 on br-lan: ok fda2:e36f:d923::2/128
Sat Feb 29 12:15:17 2020 daemon.debug odhcpd[945]: Sent 112 bytes to fe80::b196:dccf:ba12:c837%br-lan
Sat Feb 29 12:15:18 2020 daemon.debug odhcpd[945]: Received 113 Bytes from fe80::b196:dccf:ba12:c837%br-lan
Sat Feb 29 12:15:18 2020 daemon.notice odhcpd[945]: Got DHCPv6 request
Sat Feb 29 12:15:18 2020 daemon.warn odhcpd[945]: DHCPV6 REQUEST IA_NA from 00046f6d78530d9497fef9b5e0e6726f8521 on br-lan: ok fda2:e36f:d923::2/128
Sat Feb 29 12:15:18 2020 daemon.debug odhcpd[945]: Sent 112 bytes to fe80::b196:dccf:ba12:c837%br-lan
Sat Feb 29 12:15:19 2020 daemon.info dnsmasq[1396]: read /tmp/hosts/odhcpd - 1 addresses
Sat Feb 29 12:15:19 2020 daemon.debug odhcpd[945]: Received 8 Bytes from fe80::224:a5ff:feef:e8a8%eth1
Sat Feb 29 12:15:19 2020 daemon.debug odhcpd[945]: Received 56 Bytes from fe80::225:dcff:fe41:5b8f%eth1
Sat Feb 29 12:15:20 2020 daemon.warn odhcpd[945]: A default route is present but there is no public prefix on br-lan thus we don't announce a default route!
Sat Feb 29 12:15:20 2020 daemon.info odhcpd[945]: Using a RA lifetime of 0 seconds on br-lan
Sat Feb 29 12:15:20 2020 daemon.debug odhcpd[945]: Sent 120 bytes to ff02::1%br-lan
Sun Mar 1 02:44:29 2020 daemon.debug odhcpd[945]: Netlink newaddr 240b:13:2340:1800:224:a5ff:feef:e8a8%eth1
Sun Mar 1 02:44:29 2020 daemon.debug odhcpd[945]: Netlink newneigh 240b:13:2340:1800:225:dcff:fe41:5b8f%eth1
Sun Mar 1 02:44:29 2020 daemon.debug odhcpd[945]: Netlink newaddr 240b:13:2340:1810::1%br-lan
Sun Mar 1 02:44:30 2020 daemon.info dnsmasq[1396]: read /tmp/hosts/odhcpd - 2 addresses
Sun Mar 1 02:44:30 2020 daemon.info odhcpd[945]: Using a RA lifetime of 1800 seconds on br-lan
Sun Mar 1 02:44:30 2020 daemon.debug odhcpd[945]: Sent 176 bytes to ff02::1%br-lan
Sun Mar 1 02:44:31 2020 daemon.debug odhcpd[945]: Netlink newneigh fda2:e36f:d923::78c1:6660:65e2:c4b4%br-lan
Sun Mar 1 02:44:33 2020 daemon.debug odhcpd[945]: Netlink newneigh 240b:13:2340:1810:78c1:6660:65e2:c4b4%br-lan
Sun Mar 1 02:44:37 2020 daemon.debug odhcpd[945]: Netlink newneigh fda2:e36f:d923::78c1:6660:65e2:c4b4%br-lan
Sun Mar 1 02:44:37 2020 daemon.debug odhcpd[945]: Netlink newneigh fda2:e36f:d923::78c1:6660:65e2:c4b4%br-lan
From 19.07.2
Sat Feb 29 12:15:00 2020 user.notice ucitrack: Setting up /etc/config/dhcp reload dependency on /etc/config/odhcpd
Sat Feb 29 12:15:04 2020 daemon.debug odhcpd[1113]: Using a RA lifetime of 0 seconds on lan
Sat Feb 29 12:15:04 2020 daemon.notice odhcpd[1113]: Sending a RA on lan
Sat Feb 29 12:15:04 2020 daemon.err odhcpd[1113]: Failed to send to ff02::1%lan@br-lan (Address not available)
Sat Feb 29 12:15:05 2020 daemon.debug odhcpd[1113]: Netlink newaddr fda2:e36f:d923::1 on lan
Sat Feb 29 12:15:08 2020 daemon.debug odhcpd[1113]: Using a RA lifetime of 0 seconds on lan
Sat Feb 29 12:15:08 2020 daemon.notice odhcpd[1113]: Sending a RA on lan
Sat Feb 29 12:15:08 2020 daemon.debug odhcpd[1113]: Sent 120 bytes to ff02::1%lan@br-lan
Sun Mar 1 02:51:49 2020 daemon.warn odhcpd[1113]: A default route is present but there is no public prefix on lan thus we don't announce a default route!
Sun Mar 1 02:51:49 2020 daemon.debug odhcpd[1113]: Using a RA lifetime of 0 seconds on lan
Sun Mar 1 02:51:49 2020 daemon.notice odhcpd[1113]: Sending a RA on lan
Sun Mar 1 02:51:49 2020 daemon.debug odhcpd[1113]: Sent 120 bytes to ff02::1%lan@br-lan
Sun Mar 1 02:51:49 2020 daemon.debug odhcpd[1113]: Netlink newaddr 240b:13:2340:1810::1 on lan
Sun Mar 1 02:51:49 2020 daemon.info dnsmasq[1601]: read /tmp/hosts/odhcpd - 0 addresses
Sun Mar 1 02:51:49 2020 daemon.debug odhcpd[1113]: Netlink newaddr 240b:13:2340:1800:224:a5ff:feef:e8a8 on wan
Sun Mar 1 02:51:49 2020 daemon.debug odhcpd[1113]: Netlink newaddr 240b:13:2340:1800:224:a5ff:feef:e8a8 on wan6
Sun Mar 1 02:51:50 2020 daemon.debug odhcpd[1113]: Using a RA lifetime of 1800 seconds on lan
Sun Mar 1 02:51:50 2020 daemon.notice odhcpd[1113]: Sending a RA on lan
Sun Mar 1 02:51:50 2020 daemon.debug odhcpd[1113]: Sent 176 bytes to ff02::1%lan@br-lan
Sun Mar 1 02:52:41 2020 daemon.debug odhcpd[1113]: Netlink newneigh 240b:13:2340:1800:225:dcff:fe41:5b8f on wan
Sun Mar 1 02:52:41 2020 daemon.debug odhcpd[1113]: Netlink newneigh 240b:13:2340:1800:225:dcff:fe41:5b8f on wan6
Sun Mar 1 02:52:42 2020 daemon.debug odhcpd[1113]: Received 8 Bytes from fe80::b196:dccf:ba12:c837%lan@br-lan
Sun Mar 1 02:52:42 2020 daemon.debug odhcpd[1113]: Using a RA lifetime of 1800 seconds on lan
Sun Mar 1 02:52:42 2020 daemon.notice odhcpd[1113]: Sending a RA on lan
Sun Mar 1 02:52:42 2020 daemon.debug odhcpd[1113]: Sent 176 bytes to fe80::b196:dccf:ba12:c837%lan@br-lan
Sun Mar 1 02:52:42 2020 daemon.debug odhcpd[1113]: Received 99 Bytes from fe80::b196:dccf:ba12:c837%lan@br-lan
Sun Mar 1 02:52:42 2020 daemon.debug odhcpd[1113]: Got a DHCPv6-request on lan
Sun Mar 1 02:52:43 2020 daemon.debug odhcpd[1113]: Netlink newneigh fda2:e36f:d923:0:78c1:6660:65e2:c4b4 on lan
Sun Mar 1 02:52:43 2020 daemon.debug odhcpd[1113]: Received 99 Bytes from fe80::b196:dccf:ba12:c837%lan@br-lan
Sun Mar 1 02:52:43 2020 daemon.debug odhcpd[1113]: Got a DHCPv6-request on lan
Sun Mar 1 02:52:45 2020 daemon.debug odhcpd[1113]: Received 99 Bytes from fe80::b196:dccf:ba12:c837%lan@br-lan
Sun Mar 1 02:52:45 2020 daemon.debug odhcpd[1113]: Got a DHCPv6-request on lan
Sun Mar 1 02:52:46 2020 daemon.debug odhcpd[1113]: Netlink newneigh 240b:13:2340:1810:78c1:6660:65e2:c4b4 on lan
Sun Mar 1 02:52:49 2020 daemon.debug odhcpd[1113]: Received 99 Bytes from fe80::b196:dccf:ba12:c837%lan@br-lan
Sun Mar 1 02:52:49 2020 daemon.debug odhcpd[1113]: Got a DHCPv6-request on lan
There seems some difference between both log, but here I couldn't figure it out what was wrong.
I have tested this by vanilla images with minimum settings, so I believe I didn't do anything wrong.
I'm willing to do any further test if you could give me any advice.
Many thanks in advance.
--
eiji