Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

IPv6 GUA not assigned to CPE interface on boot up #407

Open
zacknewman opened this issue Nov 15, 2024 · 7 comments · May be fixed by #425
Open

IPv6 GUA not assigned to CPE interface on boot up #407

zacknewman opened this issue Nov 15, 2024 · 7 comments · May be fixed by #425

Comments

@zacknewman
Copy link

zacknewman commented Nov 15, 2024

IPv6 GUA is not assigned to WAN interface on boot anymore. I have to restart dhcpcd for it to succeed. Even more annoying is that my ISP requires IA_NA for IA_PD to work; so not only do I not get a GUA on the WAN interface, I don't get a /60 delegated to me via the link-local address. This wasn't a problem with dhcpcd 10.0.6 on OpenBSD 7.5. It just started once I upgraded to OpenBSD 7.6 which has dhcpcd 10.0.10. I went ahead and compiled dhcpcd 10.1.0, and the problem still exists.

router$ uname -a
OpenBSD router.philomathiclife.com 7.6 GENERIC.MP#338 amd64
router$ dhcpcd --version
dhcpcd 10.1.0
Copyright (c) 2006-2024 Roy Marples
Compiled in features: INET ARP ARPing IPv4LL INET6 DHCPv6 AUTH PRIVSEP
router$ cat /etc/dhcpcd.conf
noipv6rs
denyinterfaces !(em0)
allowinterfaces em0
script ""
interface em0
	duid
	iaid 0
	ia_na 0
	ia_pd 0/::/60
	ipv6rs
	leasetime -1
	nooption domain_name,domain_name_servers,domain_search,fqdn,host_name,ntp_servers,time_offset,time_servers
	option rapid_commit
	persistent
	require dhcp_server_identifier
	waitip 64

This is what is logged to /var/log/daemon when I boot up:

Nov 14 18:37:17 router dhcpcd[74863]: dhcpcd-10.1.0 starting
Nov 14 18:37:17 router dhcpcd[34604]: DUID 00:04:7d:eb:51:f7:c1:3f:11:ed:bd:36:7c:c2:55:62:31:fb
Nov 14 18:37:17 router dhcpcd[34604]: no interfaces have a carrier
Nov 14 18:37:17 router dhcpcd[34604]: em0: waiting for carrier
Nov 14 18:37:17 router dhcpcd[34604]: em0: carrier acquired
Nov 14 18:37:17 router dhcpcd[34604]: em0: IAID 00:00:00:00
Nov 14 18:37:17 router dhcpcd[34604]: em0: rebinding prior DHCPv6 lease
Nov 14 18:37:17 router dhcpcd[34604]: em0: carrier lost
Nov 14 18:37:17 router dhcpcd[34604]: em0: carrier acquired
Nov 14 18:37:17 router dhcpcd[34604]: em0: IAID 00:00:00:00
Nov 14 18:37:17 router dhcpcd[34604]: em0: rebinding prior DHCPv6 lease
Nov 14 18:37:17 router dhcpcd[34604]: em0: soliciting an IPv6 router
Nov 14 18:37:17 router dhcpcd[34604]: em0: Router Advertisement from fe80::21c:73ff:fe00:99
Nov 14 18:37:17 router dhcpcd[34604]: em0: advertised MTU 9192 is greater than link MTU 1500
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 18:37:17 router dhcpcd[34604]: em0: adding route to fd00:0:101:41::/64
Nov 14 18:37:17 router dhcpcd[34604]: em0: adding route to fd00:0:d:4::/64
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: rebinding lease of 75.70.7.176
Nov 14 18:37:17 router dhcpcd[34604]: em0: probing address 75.70.7.176/23
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: leased 75.70.7.176 for 5057 seconds
Nov 14 18:37:17 router dhcpcd[34604]: em0: adding route to 75.70.6.0/23
Nov 14 18:37:17 router dhcpcd[34604]: em0: adding default route via 75.70.6.1
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: failed to rebind prior DHCPv6 delegation
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:17 router dhcpcd[34604]: em0: no global addresses for default route
Nov 14 18:37:17 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:17 router dhcpcd[34604]: if_route (ADD): Network is unreachable
Nov 14 18:37:18 router ntpd[1395]: listening on ::1
Nov 14 18:37:18 router ntpd[1395]: listening on fdb5:d87:ae42:1::1
Nov 14 18:37:18 router ntpd[1395]: listening on 127.0.0.1
Nov 14 18:37:18 router ntpd[1395]: listening on 192.168.1.1
Nov 14 18:37:18 router ntpd[1395]: ntp engine ready
Nov 14 18:37:19 router ntpd[1395]: constraint reply from 9.9.9.9: offset -0.055418
Nov 14 18:37:19 router dhcpcd[34604]: em0: adding default route via fe80::21c:73ff:fe00:99
Nov 14 18:37:19 router dhcpcd[34604]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:37:21 router ntpd[1395]: ntp: couldn't bind to IPv6 query address: 2001:558:6040:b9:9851:c22a:89de:b915: Can't assign requested address
Nov 14 18:37:21 router ntpd[5091]: Terminating
Nov 14 18:37:21 router savecore: no core dump
Nov 14 18:37:21 router rad[47832]: startup
Nov 14 18:37:21 router httpd[99008]: startup
Nov 14 18:37:21 router redis[2611]: Server initialized
Nov 14 18:37:21 router redis[2611]: Done loading RDB, keys loaded: 22680, keys expired: 0.
Nov 14 18:37:26 router dhcpcd[34604]: em0: ADV 2001:558:6040:b9:9851:c22a:89de:b915/128 from 2001:558:4070:b8::10

Notice the ADV message at the end. Despite it, dhcpcd does not assign that GUA to em0 like it should and did before. After restarting dhcpcd, /var/log/daemon shows:

Nov 14 18:39:21 router dhcpcd[2906]: DUID 00:04:7d:eb:51:f7:c1:3f:11:ed:bd:36:7c:c2:55:62:31:fb
Nov 14 18:39:21 router dhcpcd[2906]: em0: IAID 00:00:00:00
Nov 14 18:39:22 router dhcpcd[2906]: em0: rebinding prior DHCPv6 lease
Nov 14 18:39:22 router dhcpcd[2906]: em0: rebinding lease of 75.70.7.176
Nov 14 18:39:22 router dhcpcd[2906]: em0: probing address 75.70.7.176/23
Nov 14 18:39:23 router dhcpcd[2906]: em0: soliciting an IPv6 router
Nov 14 18:39:23 router dhcpcd[2906]: em0: Router Advertisement from fe80::21c:73ff:fe00:99
Nov 14 18:39:23 router dhcpcd[2906]: em0: advertised MTU 9192 is greater than link MTU 1500
Nov 14 18:39:23 router dhcpcd[2906]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 18:39:23 router dhcpcd[2906]: em0: adding route to fd00:0:d:4::/64
Nov 14 18:39:23 router dhcpcd[2906]: em0: adding route to fd00:0:101:41::/64
Nov 14 18:39:23 router dhcpcd[2906]: em0: adding default route via fe80::21c:73ff:fe00:99
Nov 14 18:39:23 router dhcpcd[2906]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 18:39:23 router dhcpcd[2906]: em0: REPLY6 received from 2001:558:4070:b8::10
Nov 14 18:39:23 router dhcpcd[2906]: em0: adding address 2001:558:6040:b9:9851:c22a:89de:b915/128
Nov 14 18:39:23 router dhcpcd[2906]: em0: renew in 4155, rebind in 5638, expire in 7048 seconds
Nov 14 18:39:23 router dhcpcd[2906]: em0: delegated prefix 2601:283:4e01:8790::/60
Nov 14 18:39:28 router dhcpcd[2906]: em0: leased 75.70.7.176 for 4906 seconds
Nov 14 18:39:28 router dhcpcd[2906]: em0: adding route to 75.70.6.0/23
Nov 14 18:39:28 router dhcpcd[2906]: em0: adding default route via 75.70.6.1

CPE is a DOCSIS 3.1 modem which is connected to my router via a Cat 6 Ethernet cable.

Before on OpenBSD 7.5 using dhcpcd 10.0.6, a typical boot would log something similar to the following to /var/log/daemon:

Nov  2 18:46:13 router dhcpcd[33952]: dhcpcd-10.0.6 starting
Nov  2 18:46:13 router dhcpcd[34458]: DUID 00:04:7d:eb:51:f7:c1:3f:11:ed:bd:36:7c:c2:55:62:31:fb
Nov  2 18:46:13 router dhcpcd[34458]: no interfaces have a carrier
Nov  2 18:46:13 router dhcpcd[34458]: em0: waiting for carrier
Nov  2 18:46:13 router dhcpcd[34458]: em0: carrier acquired
Nov  2 18:46:13 router dhcpcd[34458]: em0: IAID 00:00:00:00
Nov  2 18:46:13 router dhcpcd[34458]: em0: soliciting a DHCPv6 lease
Nov  2 18:46:13 router dhcpcd[34458]: em0: carrier lost
Nov  2 18:46:13 router dhcpcd[34458]: em0: carrier acquired
Nov  2 18:46:13 router dhcpcd[34458]: em0: IAID 00:00:00:00
Nov  2 18:46:13 router dhcpcd[34458]: em0: soliciting a DHCPv6 lease
Nov  2 18:46:13 router dhcpcd[34458]: em0: soliciting an IPv6 router
Nov  2 18:46:13 router dhcpcd[34458]: em0: soliciting a DHCP lease
Nov  2 18:46:13 router dhcpcd[34458]: em0: Router Advertisement from fe80::21c:73ff:fe00:99
Nov  2 18:46:13 router dhcpcd[34458]: em0: advertised MTU 9192 is greater than link MTU 1500
Nov  2 18:46:13 router dhcpcd[34458]: em0: no global addresses for default route
Nov  2 18:46:13 router dhcpcd[34458]: em0: adding route to 2001:558:1028:3e9f::/64
Nov  2 18:46:13 router dhcpcd[34458]: em0: adding route to fd00:0:101:41::/64
Nov  2 18:46:13 router dhcpcd[34458]: em0: adding route to fd00:0:d:4::/64
Nov  2 18:46:13 router dhcpcd[34458]: em0: offered 75.70.7.176 from 96.113.84.152
Nov  2 18:46:13 router dhcpcd[34458]: em0: no global addresses for default route
Nov  2 18:46:13 router dhcpcd[34458]: em0: probing address 75.70.7.176/23
Nov  2 18:46:13 router dhcpcd[34458]: em0: no global addresses for default route
Nov  2 18:46:13 router dhcpcd[34458]: em0: no global addresses for default route
Nov  2 18:46:13 router dhcpcd[34458]: em0: leased 75.70.7.176 for 3600 seconds
Nov  2 18:46:13 router dhcpcd[34458]: em0: adding route to 75.70.6.0/23
Nov  2 18:46:13 router dhcpcd[34458]: em0: adding default route via 75.70.6.1
Nov  2 18:46:13 router dhcpcd[34458]: em0: no global addresses for default route
Nov  2 18:46:13 router last message repeated 11 times
Nov  2 18:46:14 router ntpd[89697]: listening on ::1
Nov  2 18:46:14 router ntpd[89697]: listening on fdb5:d87:ae42:1::1
Nov  2 18:46:14 router ntpd[89697]: listening on 127.0.0.1
Nov  2 18:46:14 router ntpd[89697]: listening on 192.168.1.1
Nov  2 18:46:14 router ntpd[89697]: ntp engine ready
Nov  2 18:46:14 router dhcpcd[34458]: em0: adding default route via fe80::21c:73ff:fe00:99
Nov  2 18:46:14 router ntpd[89697]: constraint reply from 9.9.9.9: offset 0.017217
Nov  2 18:46:16 router ntpd[89697]: cancel settime because dns probe failed
Nov  2 18:46:16 router savecore: no core dump
Nov  2 18:46:16 router rad[3692]: startup
Nov  2 18:46:16 router httpd[70943]: startup
Nov  2 18:46:16 router redis[63811]: Server initialized
Nov  2 18:46:16 router redis[63811]: Done loading RDB, keys loaded: 22681, keys expired: 0.
Nov  2 18:46:19 router dhcpcd[34458]: em0: ADV 2001:558:6040:b9:9851:c22a:89de:b915/128 from 2001:558:4070:b8::10
Nov  2 18:46:19 router dhcpcd[34458]: em0: REPLY6 received from 2001:558:4070:b8::10
Nov  2 18:46:19 router dhcpcd[34458]: em0: adding address 2001:558:6040:b9:9851:c22a:89de:b915/128
Nov  2 18:46:19 router dhcpcd[34458]: em0: renew in 2077, rebind in 2880, expire in 3600 seconds
Nov  2 18:46:19 router dhcpcd[34458]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov  2 18:46:19 router dhcpcd[34458]: em0: delegated prefix 2601:283:4e01:8790::/60

When you contrast the two, you will see a REPLY6 message that gets logged after the ADV message; so something is now happening that is stopping dhcpcd from doing whatever it used to do after receiving an ADV message so that it could receive a REPLY6 message.

@zacknewman
Copy link
Author

Went ahead and compiled master, and it is able to finally assign a GUA; however now /var/log/daemon is spammed with Network is unreachable messages every second.

/var/log/daemon before GUA is assigned:

Nov 14 19:57:57 router dhcpcd[155]: dhcpcd-10.1.0 starting
Nov 14 19:57:57 router dhcpcd[91612]: DUID 00:04:7d:eb:51:f7:c1:3f:11:ed:bd:36:7c:c2:55:62:31:fb
Nov 14 19:57:57 router dhcpcd[91612]: no interfaces have a carrier
Nov 14 19:57:57 router dhcpcd[91612]: em0: waiting for carrier
Nov 14 19:57:57 router dhcpcd[91612]: em0: carrier acquired
Nov 14 19:57:57 router dhcpcd[91612]: em0: IAID 00:00:00:00
Nov 14 19:57:57 router dhcpcd[91612]: em0: rebinding prior DHCPv6 lease
Nov 14 19:57:57 router dhcpcd[91612]: em0: carrier lost
Nov 14 19:57:57 router dhcpcd[91612]: em0: carrier acquired
Nov 14 19:57:57 router dhcpcd[91612]: em0: IAID 00:00:00:00
Nov 14 19:57:57 router dhcpcd[91612]: em0: rebinding prior DHCPv6 lease
Nov 14 19:57:57 router dhcpcd[91612]: em0: rebinding lease of 75.70.7.176
Nov 14 19:57:57 router dhcpcd[91612]: em0: soliciting an IPv6 router
Nov 14 19:57:57 router dhcpcd[91612]: em0: Router Advertisement from fe80::21c:73ff:fe00:99
Nov 14 19:57:57 router dhcpcd[91612]: em0: advertised MTU 9192 is greater than link MTU 1500
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: probing address 75.70.7.176/23
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: failed to rebind prior DHCPv6 delegation
Nov 14 19:57:57 router dhcpcd[91612]: em0: leased 75.70.7.176 for 3821 seconds
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 75.70.6.0/23
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding default route via 75.70.6.1
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: no global addresses for default route
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: lo0: adding reject route to 2601:283:4e01:8790::/60 via ::1
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:57 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:57:57 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:57:58 router ntpd[38029]: listening on ::1
Nov 14 19:57:58 router ntpd[38029]: listening on fdb5:d87:ae42:1::1
Nov 14 19:57:58 router ntpd[38029]: listening on 127.0.0.1
Nov 14 19:57:58 router ntpd[38029]: listening on 192.168.1.1
Nov 14 19:57:58 router ntpd[38029]: ntp engine ready
Nov 14 19:57:59 router ntpd[38029]: constraint reply from 2620:fe::fe: offset -0.059560
Nov 14 19:57:59 router ntpd[38029]: constraint reply from 9.9.9.9: offset -0.062036
Nov 14 19:58:01 router ntpd[38029]: ntp: couldn't bind to IPv6 query address: 2001:558:6040:b9:9851:c22a:89de:b915: Can't assign requested address
Nov 14 19:58:01 router ntpd[62328]: Terminating
Nov 14 19:58:01 router savecore: no core dump
Nov 14 19:58:01 router rad[98802]: startup
Nov 14 19:58:01 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:01 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:01 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:01 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:01 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:01 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:01 router httpd[49680]: startup
Nov 14 19:58:01 router redis[39178]: Server initialized
Nov 14 19:58:01 router redis[39178]: Done loading RDB, keys loaded: 22680, keys expired: 0.
Nov 14 19:58:01 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:01 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:01 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:01 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:01 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:01 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:04 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:04 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:04 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:04 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:04 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:04 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:05 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:05 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:05 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:05 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:05 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:05 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:07 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:07 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:07 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:07 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:07 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:07 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:08 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:08 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:08 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:08 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:08 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:08 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:10 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:10 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:10 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:10 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:10 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:10 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:12 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:12 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:12 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:12 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:12 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:12 router dhcpcd[91612]: if_route (ADD): Network is unreachable

/var/log/daemon after GUA is assigned:

Nov 14 19:58:13 router dhcpcd[91612]: em0: ADV 2001:558:6040:b9:9851:c22a:89de:b915/128 from 2001:558:4070:b8::10 (0)
Nov 14 19:58:13 router dhcpcd[91612]: em0: REPLY6 received from 2001:558:4070:b8::10
Nov 14 19:58:13 router dhcpcd[91612]: em0: adding address 2001:558:6040:b9:9851:c22a:89de:b915/128
Nov 14 19:58:13 router dhcpcd[91612]: em0: renew in 3972, rebind in 5299, expire in 6624 seconds
Nov 14 19:58:13 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:13 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:13 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:13 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:13 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:13 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:13 router dhcpcd[91612]: em0: delegated prefix 2601:283:4e01:8790::/60
Nov 14 19:58:13 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:13 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:13 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:13 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:13 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:13 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:14 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:14 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:14 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:14 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:14 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:14 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:15 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:15 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:15 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:15 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:15 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:15 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:17 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:17 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:17 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:17 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:17 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:17 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:18 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:18 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:18 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:18 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:18 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:18 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:21 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:21 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:21 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:21 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:21 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:21 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:21 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:21 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:21 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:21 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:21 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:21 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:25 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:25 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:25 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:25 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:25 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:25 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:25 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:25 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:25 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:25 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:25 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64
Nov 14 19:58:25 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:28 router dhcpcd[91612]: em0: adding route to 2001:558:1028:3e9f::/64
Nov 14 19:58:28 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:28 router dhcpcd[91612]: em0: adding route to fd00:0:d:4::/64
Nov 14 19:58:28 router dhcpcd[91612]: if_route (ADD): Network is unreachable
Nov 14 19:58:28 router dhcpcd[91612]: em0: adding route to fd00:0:101:41::/64

@zacknewman
Copy link
Author

zacknewman commented Nov 16, 2024

Not sure if it's a coincidence, but I moved start_daemon dhcpcd >/dev/null 2>&1 so that it's immediately after sh /etc/netstart instead of immediately before in /etc/rc. For the past few years, it's been fine where it was with the only issue being an IPv6 timeout that would cause dhcpcd to not assign IPv6 addresses until later (as can be seen in the above logs and is why ntpd regularly fails on boot).

I started dhcpcd before netstart since that is where the base network daemons start (e.g., dhcpleased), but putting it after seems fine too. I'm guessing it's working now since the timeout no longer occurs which #376 fixed. That issue didn't exist in dhcpcd 10.0.6 and likely earlier versions, so not sure what changes broke it; but as stated, #376 fixed it.

There is still an issue with master with the Network is unreachable messages being logged almost every second though. For now I'm back to running dhcpcd 10.0.10—the version in OpenBSD 7.6—and now just start dhcpcd in rc(8) a little later.

@rsmarples
Copy link
Member

Does reverting e3c5de1 help with the Network is unreachable error?

@zacknewman
Copy link
Author

Does reverting e3c5de1 help with the Network is unreachable error?

It does. What is "IPv6 address sharing"? My DuckDuckGo-fu is failing me.

@rsmarples
Copy link
Member

Does reverting e3c5de1 help with the Network is unreachable error?

It does. What is "IPv6 address sharing"? My DuckDuckGo-fu is failing me.

So this is when the same IPv6 address is assigned to two or more interfaces.
In this instance, we need to set the out going interface for the route rather than the address as the address by itself isn't enough scope.

What's odd is that on my OpenBSD-7.6 VM i cannot replicate this, so I thought it was fixed. I even gave it the same prefix delegation! Could you please email me the lease6 file dhcpcd created? By default it should be /var/db/dhcpcd/em0.lease6, I don't recall if the OpenBSD port changes the default path or not. I'd like to run it on my VM to see if I'm doing something funky or not.

@zacknewman
Copy link
Author

So this is when the same IPv6 address is assigned to two or more interfaces. In this instance, we need to set the out going interface for the route rather than the address as the address by itself isn't enough scope.

I'm guessing I'm still confused, but

router$ route -n show -inet6
Routing tables

Internet6:
Destination                                 Gateway                                 Flags   Refs      Use   Mtu  Prio Iface
⋮
2001:558:1028:3e9f::/64                     link#4                                  UCn        0        0  1500     4 em0
⋮
fd00:0:d:4::/64                             link#4                                  UCn        0        2  1500     4 em0
fd00:0:101:41::/64                          link#4                                  UCn        0     3186  1500     4 em0
⋮

and

router$ route -nv get fd00:0:101:41::/64
so_dst: inet6 fd00:0:101:41::; so_mask: inet6 ffff:ffff:ffff:ffff::; so_ifp: link ; RTM_GET: Report Metrics: len 192, priority 0, table 0, if# 0, pid: 0, seq 1, errno 0
flags:<UP,GATEWAY,STATIC>
fmask:
use:        0   mtu:        0    expire:        0
locks:  inits:
sockaddrs: <DST,NETMASK,IFP>
 fd00:0:101:41:: ffff:ffff:ffff:ffff:: link#0
   route to: fd00:0:101:41::
destination: fd00:0:101:41::
       mask: ffff:ffff:ffff:ffff::
  interface: em0
 if address: fe80::7ec2:55ff:fe62:31fb%em0
   priority: 4 (connected)
      flags: <UP,DONE,CLONING,CONNECTED>
     use       mtu    expire
    3196      1500         0

locks:  inits:
sockaddrs: <DST,GATEWAY,NETMASK,IFP,IFA>
 fd00:0:101:41:: link#4 ffff:ffff:ffff:ffff:: 7c:c2:55:62:31:fb fe80::7ec2:55ff:fe62:31fb%em0

make it seem like those /64s are routed out em0. Are there supposed to be other entries where instead of link#4 being the Gateway, the MAC address of em0 is supposed to be the Gateway for those Destinations? What's the difference between "link" and the interface?

What's odd is that on my OpenBSD-7.6 VM i cannot replicate this, so I thought it was fixed. I even gave it the same prefix delegation! Could you please email me the lease6 file dhcpcd created? By default it should be /var/db/dhcpcd/em0.lease6, I don't recall if the OpenBSD port changes the default path or not. I'd like to run it on my VM to see if I'm doing something funky or not.

Sent.

@rsmarples
Copy link
Member

make it seem like those /64s are routed out em0. Are there supposed to be other entries where instead of link#4 being the Gateway, the MAC address of em0 is supposed to be the Gateway for those Destinations? What's the difference between "link" and the interface?

In that output, link#4 is the interface with index 4. Effectively it means the prefix is on-link - or directly connected to the interface. The interface is the outbound interface as denoted by the hardware address.
The two can be different oddly enough - but in this case they should end up being the same.

What's odd is that on my OpenBSD-7.6 VM i cannot replicate this, so I thought it was fixed. I even gave it the same prefix delegation! Could you please email me the lease6 file dhcpcd created? By default it should be /var/db/dhcpcd/em0.lease6, I don't recall if the OpenBSD port changes the default path or not. I'd like to run it on my VM to see if I'm doing something funky or not.

Sent.

Thanks.
I'm busy in my personal life for a week or so, but will try to look at it time permitting.

@zacknewman zacknewman linked a pull request Dec 9, 2024 that will close this issue
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging a pull request may close this issue.

2 participants