RADVD and IPv6 Killed by Modem Reboot
-
Ohhhhh, I see now. I had made comments in the bug and forums that I am now retaining IPv6 addressing after a cable modem reboot. Now I see the difference from my setup and what is being discussed here.
My pfSense installation is running in an ESXi VM. So, when the CM reboots, apinger declares the gateway down, but I don't see an actual interface link loss.
It used to be that if the gateway was down, IPv6 addressing would be lost, radvd killed and never recover without a reboot. That has been fixed.
However, the link loss handled by rc.link up is apparently still broken.
Hope that clarifies it for Ermal and team.
-
Unfortunately I'm not that familiar with PHP. I was looking around to try and figure out why this keeps happening (other than my modem is rebooting). The file services.inc has the string "Shutting down Router Advertisment daemon cleanly". It looks like the function services_radvd_configure gets some sort of config array for dhcpdv6. So long as there are greater than 0 elements in this new array it'll simply restart RADVD. Otherwise it shuts it down cleanly. Based on the logfile, it would seem that there should be 0 elements because the modem only provides the 192.168.100.0/24 subnet with no IPv6. Thus, it seems like it is correct in shutting down RADVD during this period.
However, when normal connectivity is restored, what is supposed to (re)start RADVD?
-
It is normal to get the radvd service shutdown when your ipv6 lease expires.
Normally when the modem hands over a temporary ipv4 lease it should handover even a v6 lease.Not sure how you can build a reliable configuration process for v6 if the modem does not treat it as first class?
-
I don't think it would be normal for a modem to hand out a v6 lease in this case. Essentially it is disconnected from the cable company during this period. What v6 lease would it have to hand out? I strongly suspect all cable modems do this.
During bootup, pfsense assumes v6 is around and so initiates DHCP6 or whatever it's configured for*. The issue is when the WAN link goes down and pfsense is introduced to a v4-only network. Pfsense rightly turns off v6 stuff. But when the network changes again to a v4/v6 network, pfsense needs to assume that v6 might once again be available and go about it's usual v6 configuration setup. Or somehow detect that v6 is available again.
- I assume this is what pfsense does
-
As I had mentioned earlier, I think given the reality of how IPv6 is deployed to consumers through cable today, pfSense should not assume that IPv6 connectivity can only change at boot time and when the physical WAN link goes up/down (which I think is what it's doing now?); at the very least, it should assume that IPv6 connectivity can also (re-)appear anytime the IPv4 lease on the LAN expires.
-
@ermal:
Normally when the modem hands over a temporary ipv4 lease it should handover even a v6 lease.
I'm not aware of any DOCSIS 3.0 cable modem that would do this.
-
I put a fix and should be on new snapshots.
Test those out and it should fix what you are seeing.
Especially you should have get the v6 information from v4 setting ticket on. -
@ermal:
Especially you should have get the v6 information from v4 setting ticket on.
Is this safe to do for a cable modem setup (IPv4 configuration type = DHCP, IPv6 configuration type = DHCP6)? What exactly does this option actually do anyway? The description is not particularly helpful in figuring out under which circumstances this setting should be enabled, and from reading the board I just have vague memories of it being somehow related to PPPoE (which I don't think is typically used with cable modems).
-
Especially you should have get the v6 information from v4 setting ticket on
I wasn't sure what was meant for this so I tried the Interface -> WAN setting that says
Request a IPv6 prefix/information through the IPv4 connectivity link
This completely prevented pfsense from getting IPv6 connectivity.
The fix didn't seem to work as power cycling the modem still caused a loss of IPv6 connectivity until some user intervention occurred.
The version is 2.1-RC2 (i386) built on Thu Sep 5 09:59:12 EDT 2013.
-
Especially you should have get the v6 information from v4 setting ticket on
I wasn't sure what was meant for this so I tried the Interface -> WAN setting that says
It should work for you with this option ticket on.
Since it will restart ipv6 anytime you get a new ipv4.Request a IPv6 prefix/information through the IPv4 connectivity link
This completely prevented pfsense from getting IPv6 connectivity.
The fix didn't seem to work as power cycling the modem still caused a loss of IPv6 connectivity until some user intervention occurred.
The version is 2.1-RC2 (i386) built on Thu Sep 5 09:59:12 EDT 2013.
Is not for you.
-
I upgraded to 2.1-RC2 (i386) built on Fri Sep 6 08:32:59 EDT 2013 FreeBSD 8.3-RELEASE-p10 but I still lost all IPv6 connectivity this morning when the modem rebooted randomly.
-
Can you provide system log for this and describe your setup?
-
The system is an Alix 2D3 board. I only use the WAN and LAN. DHCP and DHCP6-PD on the WAN. Direct connection between the modem and pfsense's WAN. No packages except the openvpn client export.
The log looks quite similar to the one I posted previously. I filtered out "pf:|ntp|openvpn|dhcpd|dnsmasq|arpresolve:" so if you want the logs that include those terms, let me know.
Sep 6 21:29:39 cerberus.localdomain apinger: ALARM: WAN_DHCP(67.x.y.1) *** down *** Sep 6 21:29:39 cerberus.localdomain apinger: ALARM: WAN_DHCP6(fe80::201:5cff:fe62:c446%vr1) *** down *** Sep 6 21:29:49 cerberus.localdomain check_reload_status: updating dyndns WAN_DHCP Sep 6 21:29:49 cerberus.localdomain check_reload_status: Restarting ipsec tunnels Sep 6 21:29:49 cerberus.localdomain check_reload_status: Restarting OpenVPN tunnels/interfaces Sep 6 21:29:49 cerberus.localdomain check_reload_status: Reloading filter Sep 6 21:29:49 cerberus.localdomain check_reload_status: updating dyndns WAN_DHCP6 Sep 6 21:29:49 cerberus.localdomain check_reload_status: Restarting OpenVPN tunnels/interfaces Sep 6 21:30:10 cerberus.localdomain check_reload_status: Linkup starting vr1 Sep 6 21:30:10 cerberus.localdomain kernel: vr1: link state changed to DOWN Sep 6 21:30:14 cerberus.localdomain php: rc.linkup: DEVD Ethernet detached event for wan Sep 6 21:30:15 cerberus.localdomain dhclient[9504]: connection closed Sep 6 21:30:15 cerberus.localdomain dhclient[9504]: exiting. Sep 6 21:30:19 cerberus.localdomain php: rc.linkup: Clearing states to old gateway 67.x.y.1. Sep 6 21:30:31 cerberus.localdomain kernel: cannot forward src fe80:1::96de:80ff:fe76:b365, dst 2601:9:7680:6fc:20d:b9ff:fe1c:4ad0, nxt 58, rcvif vr0, outif vr1 Sep 6 21:30:33 cerberus.localdomain check_reload_status: Linkup starting vr1 Sep 6 21:30:33 cerberus.localdomain kernel: vr1: link state changed to UP Sep 6 21:30:38 cerberus.localdomain php: rc.linkup: DEVD Ethernet attached event for wan Sep 6 21:30:38 cerberus.localdomain php: rc.linkup: HOTPLUG: Configuring interface wan Sep 6 21:30:38 cerberus.localdomain php: rc.linkup: The command '/sbin/ifconfig 'vr1' inet delete' returned exit code '1', the output was 'ifconfig: ioctl (SIOCDIFADDR): Can't assign requested address' Sep 6 21:30:38 cerberus.localdomain dhclient: PREINIT Sep 6 21:30:38 cerberus.localdomain dhclient: Starting delete_old_states() Sep 6 21:30:38 cerberus.localdomain dhclient: Comparing IPs: Old: New: Sep 6 21:30:38 cerberus.localdomain dhclient[91152]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 6 21:30:38 cerberus.localdomain dhclient[91152]: DHCPNAK from 192.168.100.1 Sep 6 21:30:38 cerberus.localdomain dhclient[91152]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 2 Sep 6 21:30:40 cerberus.localdomain dhclient[91152]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 5 Sep 6 21:30:40 cerberus.localdomain kernel: ovpns2: link state changed to DOWN Sep 6 21:30:40 cerberus.localdomain check_reload_status: Reloading filter Sep 6 21:30:40 cerberus.localdomain dhclient[91152]: DHCPOFFER from 192.168.100.1 Sep 6 21:30:40 cerberus.localdomain dhclient: ARPSEND Sep 6 21:30:40 cerberus.localdomain dhclient[91152]: DHCPOFFER from 192.168.100.1 Sep 6 21:30:40 cerberus.localdomain dhclient[91152]: DHCPOFFER already seen. Sep 6 21:30:42 cerberus.localdomain dhclient: ARPCHECK Sep 6 21:30:42 cerberus.localdomain dhclient[91152]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 6 21:30:42 cerberus.localdomain dhclient[91152]: DHCPACK from 192.168.100.1 Sep 6 21:30:42 cerberus.localdomain dhclient: BOUND Sep 6 21:30:42 cerberus.localdomain dhclient: Starting delete_old_states() Sep 6 21:30:42 cerberus.localdomain dhclient: Comparing IPs: Old: New: 192.168.100.10 Sep 6 21:30:42 cerberus.localdomain dhclient: Starting add_new_address() Sep 6 21:30:42 cerberus.localdomain dhclient: ifconfig vr1 inet 192.168.100.10 netmask 255.255.255.0 broadcast 192.168.100.255 Sep 6 21:30:42 cerberus.localdomain dhclient: New IP Address (vr1): 192.168.100.10 Sep 6 21:30:42 cerberus.localdomain dhclient: New Subnet Mask (vr1): 255.255.255.0 Sep 6 21:30:42 cerberus.localdomain dhclient: New Broadcast Address (vr1): 192.168.100.255 Sep 6 21:30:42 cerberus.localdomain dhclient: New Routers (vr1): 192.168.100.1 Sep 6 21:30:42 cerberus.localdomain dhclient: Adding new routes to interface: vr1 Sep 6 21:30:42 cerberus.localdomain dhclient: /sbin/route add default 192.168.100.1 Sep 6 21:30:42 cerberus.localdomain dhclient: Creating resolv.conf Sep 6 21:30:42 cerberus.localdomain dhclient[91152]: bound to 192.168.100.10 -- renewal in 30 seconds. Sep 6 21:30:42 cerberus.localdomain php: rc.linkup: Accept router advertisements on interface vr1 Sep 6 21:30:42 cerberus.localdomain check_reload_status: rc.newwanip starting vr1 Sep 6 21:30:42 cerberus.localdomain php: rc.linkup: ROUTING: setting default route to 192.168.100.1 Sep 6 21:30:43 cerberus.localdomain dhcp6c[19206]: client6_timo: no responses were received Sep 6 21:30:45 cerberus.localdomain dhcp6c[19206]: client6_timo: no responses were received Sep 6 21:30:45 cerberus.localdomain dhcp6c[19206]: check_exit: exiting Sep 6 21:30:48 cerberus.localdomain php: rc.linkup: Shutting down Router Advertisment daemon cleanly Sep 6 21:30:48 cerberus.localdomain radvd[32292]: Exiting, sigterm or sigint received. Sep 6 21:30:48 cerberus.localdomain radvd[32292]: sending stop adverts Sep 6 21:30:48 cerberus.localdomain radvd[32292]: removing /var/run/radvd.pid Sep 6 21:30:48 cerberus.localdomain check_reload_status: updating dyndns wan Sep 6 21:30:49 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting vr1. Sep 6 21:30:49 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 192.168.100.10) (interface: wan) (real interface: vr1). Sep 6 21:30:49 cerberus.localdomain php: rc.newwanip: ROUTING: setting default route to 192.168.100.1 Sep 6 21:30:49 cerberus.localdomain apinger: SIGHUP received, reloading configuration. Sep 6 21:30:49 cerberus.localdomain apinger: alarm canceled (config reload): WAN_DHCP(67.x.y.1) *** down *** Sep 6 21:30:49 cerberus.localdomain apinger: alarm canceled (config reload): WAN_DHCP6(fe80::201:5cff:fe62:c446%vr1) *** down *** Sep 6 21:30:52 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 6 21:30:54 cerberus.localdomain php: rc.newwanip: Resyncing OpenVPN instances for interface WAN. Sep 6 21:30:54 cerberus.localdomain kernel: ovpns1: link state changed to DOWN Sep 6 21:30:54 cerberus.localdomain check_reload_status: Reloading filter Sep 6 21:30:55 cerberus.localdomain kernel: ovpns1: link state changed to UP Sep 6 21:30:55 cerberus.localdomain kernel: ovpns2: link state changed to UP Sep 6 21:30:55 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns1 Sep 6 21:30:55 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns2 Sep 6 21:30:57 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change 67.x.y.z -> 192.168.100.10 ... Restarting packages. Sep 6 21:30:57 cerberus.localdomain check_reload_status: Starting packages Sep 6 21:31:03 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns2. Sep 6 21:31:03 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.249.1) (interface: ) (real interface: ovpns2). Sep 6 21:31:03 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns1. Sep 6 21:31:03 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change -> 172.29.249.1 ... Restarting packages. Sep 6 21:31:03 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.251.1) (interface: ) (real interface: ovpns1). Sep 6 21:31:03 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change -> 172.29.251.1 ... Restarting packages. Sep 6 21:31:06 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages. Sep 6 21:31:10 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 6 21:31:12 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 6 21:31:13 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 6 21:31:14 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages. Sep 6 21:31:14 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 6 21:31:16 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 6 21:31:16 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 6 21:31:18 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 6 21:31:20 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 6 21:31:23 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 6 21:31:36 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 6 21:31:36 cerberus.localdomain dhclient[99092]: DHCPNAK from 96.120.88.245 Sep 6 21:31:36 cerberus.localdomain dhclient[99092]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 1 Sep 6 21:31:36 cerberus.localdomain dhclient[99092]: DHCPOFFER from 96.120.88.245 Sep 6 21:31:36 cerberus.localdomain dhclient: ARPSEND Sep 6 21:31:38 cerberus.localdomain dhclient: ARPCHECK Sep 6 21:31:38 cerberus.localdomain dhclient[99092]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 6 21:31:38 cerberus.localdomain dhclient[99092]: DHCPACK from 96.120.88.245 Sep 6 21:31:38 cerberus.localdomain dhclient: BOUND Sep 6 21:31:38 cerberus.localdomain dhclient: Starting delete_old_states() Sep 6 21:31:38 cerberus.localdomain dhclient: Comparing IPs: Old: New: 67.x.y.z Sep 6 21:31:38 cerberus.localdomain dhclient: Starting add_new_address() Sep 6 21:31:38 cerberus.localdomain dhclient: ifconfig vr1 inet 67.x.y.z netmask 255.255.252.0 broadcast 255.255.255.255 Sep 6 21:31:38 cerberus.localdomain dhclient: New IP Address (vr1): 67.x.y.z Sep 6 21:31:38 cerberus.localdomain dhclient: New Subnet Mask (vr1): 255.255.252.0 Sep 6 21:31:38 cerberus.localdomain dhclient: New Broadcast Address (vr1): 255.255.255.255 Sep 6 21:31:38 cerberus.localdomain dhclient: New Routers (vr1): 67.x.y.1 Sep 6 21:31:38 cerberus.localdomain dhclient: Adding new routes to interface: vr1 Sep 6 21:31:38 cerberus.localdomain dhclient: /sbin/route add default 67.x.y.1 Sep 6 21:31:38 cerberus.localdomain dhclient: Creating resolv.conf Sep 6 21:31:38 cerberus.localdomain check_reload_status: rc.newwanip starting vr1 Sep 6 21:31:39 cerberus.localdomain dhclient[99092]: bound to 67.x.y.z -- renewal in 172800 seconds. Sep 6 21:31:43 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting vr1. Sep 6 21:31:43 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 67.x.y.z) (interface: wan) (real interface: vr1). Sep 6 21:31:43 cerberus.localdomain php: rc.newwanip: ROUTING: setting default route to 67.x.y.1 Sep 6 21:31:43 cerberus.localdomain apinger: SIGHUP received, reloading configuration. Sep 6 21:31:48 cerberus.localdomain php: rc.newwanip: Resyncing OpenVPN instances for interface WAN. Sep 6 21:31:48 cerberus.localdomain kernel: ovpns1: link state changed to DOWN Sep 6 21:31:48 cerberus.localdomain check_reload_status: Reloading filter Sep 6 21:31:49 cerberus.localdomain kernel: ovpns1: link state changed to UP Sep 6 21:31:49 cerberus.localdomain kernel: ovpns2: link state changed to DOWN Sep 6 21:31:49 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns1 Sep 6 21:31:49 cerberus.localdomain kernel: ovpns2: link state changed to UP Sep 6 21:31:49 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns2 Sep 6 21:31:51 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change 192.168.100.10 -> 67.x.y.z ... Restarting packages. Sep 6 21:31:51 cerberus.localdomain check_reload_status: Starting packages Sep 6 21:31:56 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns1. Sep 6 21:31:56 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.251.1) (interface: ) (real interface: ovpns1). Sep 6 21:31:57 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change -> 172.29.251.1 ... Restarting packages. Sep 6 21:31:57 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns2. Sep 6 21:31:57 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.249.1) (interface: ) (real interface: ovpns2). Sep 6 21:31:57 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change -> 172.29.249.1 ... Restarting packages. Sep 6 21:32:00 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages. Sep 6 21:32:04 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 6 21:32:07 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages. Sep 6 21:32:10 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 6 21:32:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
-
Can you sync to 2.1-RELEASE code and retry and also re-post the system log?
I need to see an event fired that is not logged at the moment.
-
Did a gitsync with pfSsh.php playback gitsync RELENG_2_1
Rebooted system.
Unplugged power to modem. Plugged it back in. IPv6 did not return.Here's the system log. This time I only filtered out "pf:|ntpd|openvpn"
Sep 10 20:49:11 cerberus.localdomain kernel: vr1: link state changed to DOWN Sep 10 20:49:15 cerberus.localdomain php: rc.linkup: DEVD Ethernet detached event for wan Sep 10 20:49:15 cerberus.localdomain dhclient[9345]: connection closed Sep 10 20:49:15 cerberus.localdomain dhclient[9345]: exiting. Sep 10 20:49:17 cerberus.localdomain kernel: arpresolve: can't allocate llinfo for 67.x.y.1 Sep 10 20:49:19 cerberus.localdomain php: rc.linkup: Clearing states to old gateway 67.x.y.1. Sep 10 20:49:19 cerberus.localdomain apinger: ALARM: WAN_DHCP(67.x.y.1) *** down *** Sep 10 20:49:19 cerberus.localdomain apinger: ALARM: WAN_DHCP6(fe80::201:5cff:fe62:c446%vr1) *** down *** Sep 10 20:49:29 cerberus.localdomain check_reload_status: updating dyndns WAN_DHCP Sep 10 20:49:29 cerberus.localdomain check_reload_status: Restarting ipsec tunnels Sep 10 20:49:29 cerberus.localdomain check_reload_status: Restarting OpenVPN tunnels/interfaces Sep 10 20:49:29 cerberus.localdomain check_reload_status: Reloading filter Sep 10 20:49:29 cerberus.localdomain check_reload_status: updating dyndns WAN_DHCP6 Sep 10 20:49:29 cerberus.localdomain check_reload_status: Restarting OpenVPN tunnels/interfaces Sep 10 20:49:34 cerberus.localdomain kernel: vr1: link state changed to UP Sep 10 20:49:34 cerberus.localdomain check_reload_status: Linkup starting vr1 Sep 10 20:49:36 cerberus.localdomain kernel: vr1: link state changed to DOWN Sep 10 20:49:36 cerberus.localdomain check_reload_status: Linkup starting vr1 Sep 10 20:49:38 cerberus.localdomain kernel: vr1: link state changed to UP Sep 10 20:49:38 cerberus.localdomain check_reload_status: Linkup starting vr1 Sep 10 20:49:42 cerberus.localdomain dhcp6c[20389]: client6_timo: no responses were received Sep 10 20:49:44 cerberus.localdomain php: rc.linkup: DEVD Ethernet attached event for wan Sep 10 20:49:44 cerberus.localdomain php: rc.linkup: HOTPLUG: Configuring interface wan Sep 10 20:49:45 cerberus.localdomain php: rc.linkup: DEVD Ethernet detached event for wan Sep 10 20:49:45 cerberus.localdomain php: rc.linkup: The command '/sbin/ifconfig 'vr1' inet delete' returned exit code '1', the output was 'ifconfig: ioctl (SIOCDIFADDR): Can't assign requested address' Sep 10 20:49:45 cerberus.localdomain dhclient: PREINIT Sep 10 20:49:45 cerberus.localdomain php: rc.linkup: DEVD Ethernet attached event for wan Sep 10 20:49:45 cerberus.localdomain php: rc.linkup: HOTPLUG: Configuring interface wan Sep 10 20:49:45 cerberus.localdomain dhclient: Starting delete_old_states() Sep 10 20:49:46 cerberus.localdomain dhclient: Comparing IPs: Old: New: Sep 10 20:49:46 cerberus.localdomain dhclient[84541]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 10 20:49:46 cerberus.localdomain dhclient[84541]: DHCPNAK from 192.168.100.1 Sep 10 20:49:46 cerberus.localdomain dhclient[84541]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 1 Sep 10 20:49:46 cerberus.localdomain dhcp6c[20389]: client6_timo: no responses were received Sep 10 20:49:46 cerberus.localdomain dhcp6c[20389]: check_exit: exiting Sep 10 20:49:46 cerberus.localdomain php: rc.linkup: The command '/sbin/ifconfig 'vr1' inet delete' returned exit code '1', the output was 'ifconfig: ioctl (SIOCDIFADDR): Can't assign requested address' Sep 10 20:49:46 cerberus.localdomain dhclient[86700]: dhclient already running, pid: 84541. Sep 10 20:49:46 cerberus.localdomain dhclient[86700]: exiting. Sep 10 20:49:46 cerberus.localdomain php: rc.linkup: The command '/sbin/dhclient -c /var/etc/dhclient_wan.conf vr1 > /tmp/vr1_output 2> /tmp/vr1_error_output' returned exit code '1', the output was '' Sep 10 20:49:46 cerberus.localdomain php: rc.linkup: Accept router advertisements on interface vr1 Sep 10 20:49:47 cerberus.localdomain dhclient[84541]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 2 Sep 10 20:49:47 cerberus.localdomain dhclient[84541]: DHCPOFFER from 192.168.100.1 Sep 10 20:49:47 cerberus.localdomain dhclient: ARPSEND Sep 10 20:49:47 cerberus.localdomain dhclient[84541]: DHCPOFFER from 192.168.100.1 Sep 10 20:49:47 cerberus.localdomain dhclient[84541]: DHCPOFFER already seen. Sep 10 20:49:48 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:48 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 10 20:49:48 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:49 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:49 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:49 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:49 cerberus.localdomain dhclient: ARPCHECK Sep 10 20:49:49 cerberus.localdomain dhclient[84541]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 10 20:49:49 cerberus.localdomain dhclient[84541]: DHCPACK from 192.168.100.1 Sep 10 20:49:49 cerberus.localdomain dhclient: BOUND Sep 10 20:49:49 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:49 cerberus.localdomain dhclient: Starting delete_old_states() Sep 10 20:49:49 cerberus.localdomain dhclient: Comparing IPs: Old: New: 192.168.100.10 Sep 10 20:49:49 cerberus.localdomain dhclient: Starting add_new_address() Sep 10 20:49:49 cerberus.localdomain dhclient: ifconfig vr1 inet 192.168.100.10 netmask 255.255.255.0 broadcast 192.168.100.255 Sep 10 20:49:49 cerberus.localdomain dhclient: New IP Address (vr1): 192.168.100.10 Sep 10 20:49:49 cerberus.localdomain dhclient: New Subnet Mask (vr1): 255.255.255.0 Sep 10 20:49:49 cerberus.localdomain dhclient: New Broadcast Address (vr1): 192.168.100.255 Sep 10 20:49:49 cerberus.localdomain dhclient: New Routers (vr1): 192.168.100.1 Sep 10 20:49:49 cerberus.localdomain dhclient: Adding new routes to interface: vr1 Sep 10 20:49:49 cerberus.localdomain php: rc.linkup: Clearing states to old gateway 192.168.100.1. Sep 10 20:49:49 cerberus.localdomain dhclient: /sbin/route add default 192.168.100.1 Sep 10 20:49:49 cerberus.localdomain dhclient: Creating resolv.conf Sep 10 20:49:49 cerberus.localdomain check_reload_status: rc.newwanip starting vr1 Sep 10 20:49:49 cerberus.localdomain dhclient[84541]: bound to 192.168.100.10 -- renewal in 30 seconds. Sep 10 20:49:49 cerberus.localdomain php: rc.linkup: Accept router advertisements on interface vr1 Sep 10 20:49:49 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:49 cerberus.localdomain dnsmasq[36693]: exiting on receipt of SIGTERM Sep 10 20:49:49 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:50 cerberus.localdomain dnsmasq[97041]: started, version 2.66 cachesize 10000 Sep 10 20:49:50 cerberus.localdomain dnsmasq[97041]: compile time options: IPv6 GNU-getopt no-DBus i18n IDN DHCP DHCPv6 no-Lua TFTP no-conntrack no-ipset auth Sep 10 20:49:51 cerberus.localdomain dnsmasq[97041]: reading /etc/resolv.conf Sep 10 20:49:51 cerberus.localdomain dnsmasq[97041]: using nameserver 75.75.76.76#53 Sep 10 20:49:51 cerberus.localdomain dnsmasq[97041]: using nameserver 75.75.75.75#53 Sep 10 20:49:51 cerberus.localdomain dnsmasq[97041]: using nameserver 2001:558:feed::2#53 Sep 10 20:49:51 cerberus.localdomain dnsmasq[97041]: using nameserver 2001:558:feed::1#53 Sep 10 20:49:51 cerberus.localdomain dnsmasq[97041]: ignoring nameserver 127.0.0.1 - local interface Sep 10 20:49:51 cerberus.localdomain dnsmasq[97041]: read /etc/hosts - 2 addresses Sep 10 20:49:51 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:51 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:49:52 cerberus.localdomain dnsmasq[97041]: exiting on receipt of SIGTERM Sep 10 20:49:52 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1 Sep 10 20:49:52 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium. Sep 10 20:49:52 cerberus.localdomain dhcpd: All rights reserved. Sep 10 20:49:52 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/ Sep 10 20:49:52 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1 Sep 10 20:49:52 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium. Sep 10 20:49:52 cerberus.localdomain dhcpd: All rights reserved. Sep 10 20:49:52 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/ Sep 10 20:49:52 cerberus.localdomain dhcpd: Wrote 0 deleted host decls to leases file. Sep 10 20:49:52 cerberus.localdomain dhcpd: Wrote 0 new dynamic host decls to leases file. Sep 10 20:49:52 cerberus.localdomain dhcpd: Wrote 3 leases to leases file. Sep 10 20:49:53 cerberus.localdomain dhcpd: Listening on BPF/vr0/00:0d:b9:1c:4a:d0/192.168.112.0/24 Sep 10 20:49:53 cerberus.localdomain dhcpd: Sending on BPF/vr0/00:0d:b9:1c:4a:d0/192.168.112.0/24 Sep 10 20:49:53 cerberus.localdomain dhcpd: Sending on Socket/fallback/fallback-net Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: started, version 2.66 cachesize 10000 Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: compile time options: IPv6 GNU-getopt no-DBus i18n IDN DHCP DHCPv6 no-Lua TFTP no-conntrack no-ipset auth Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: reading /etc/resolv.conf Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: using nameserver 75.75.76.76#53 Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: using nameserver 75.75.75.75#53 Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: using nameserver 2001:558:feed::2#53 Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: using nameserver 2001:558:feed::1#53 Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: ignoring nameserver 127.0.0.1 - local interface Sep 10 20:49:53 cerberus.localdomain dnsmasq[6118]: read /etc/hosts - 2 addresses Sep 10 20:49:54 cerberus.localdomain php: rc.linkup: Shutting down Router Advertisment daemon cleanly Sep 10 20:49:54 cerberus.localdomain radvd[32891]: Exiting, sigterm or sigint received. Sep 10 20:49:54 cerberus.localdomain radvd[32891]: sending stop adverts Sep 10 20:49:54 cerberus.localdomain radvd[32891]: removing /var/run/radvd.pid Sep 10 20:49:54 cerberus.localdomain check_reload_status: updating dyndns wan Sep 10 20:49:54 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1 Sep 10 20:49:54 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium. Sep 10 20:49:54 cerberus.localdomain dhcpd: All rights reserved. Sep 10 20:49:54 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/ Sep 10 20:49:54 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1 Sep 10 20:49:54 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium. Sep 10 20:49:54 cerberus.localdomain dhcpd: All rights reserved. Sep 10 20:49:54 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/ Sep 10 20:49:54 cerberus.localdomain dhcpd: Wrote 0 deleted host decls to leases file. Sep 10 20:49:54 cerberus.localdomain dhcpd: Wrote 0 new dynamic host decls to leases file. Sep 10 20:49:54 cerberus.localdomain dhcpd: Wrote 3 leases to leases file. Sep 10 20:49:54 cerberus.localdomain dhcpd: Listening on BPF/vr0/00:0d:b9:1c:4a:d0/192.168.112.0/24 Sep 10 20:49:54 cerberus.localdomain dhcpd: Sending on BPF/vr0/00:0d:b9:1c:4a:d0/192.168.112.0/24 Sep 10 20:49:54 cerberus.localdomain dhcpd: Sending on Socket/fallback/fallback-net Sep 10 20:49:55 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting vr1. Sep 10 20:49:55 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 192.168.100.10) (interface: wan) (real interface: vr1). Sep 10 20:49:55 cerberus.localdomain apinger: SIGHUP received, reloading configuration. Sep 10 20:49:55 cerberus.localdomain apinger: alarm canceled (config reload): WAN_DHCP(67.x.y.1) *** down *** Sep 10 20:49:55 cerberus.localdomain apinger: alarm canceled (config reload): WAN_DHCP6(fe80::201:5cff:fe62:c446%vr1) *** down *** Sep 10 20:49:55 cerberus.localdomain apinger: No usable targets found, exiting Sep 10 20:50:00 cerberus.localdomain php: rc.newwanip: Resyncing OpenVPN instances for interface WAN. Sep 10 20:50:02 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change 67.x.y.z -> 192.168.100.10 ... Restarting packages. Sep 10 20:50:03 cerberus.localdomain check_reload_status: Starting packages Sep 10 20:50:03 cerberus.localdomain check_reload_status: Reloading filter Sep 10 20:50:04 cerberus.localdomain dnsmasq[6118]: reading /etc/resolv.conf Sep 10 20:50:04 cerberus.localdomain dnsmasq[6118]: using nameserver 2001:558:feed::2#53 Sep 10 20:50:04 cerberus.localdomain dnsmasq[6118]: using nameserver 2001:558:feed::1#53 Sep 10 20:50:04 cerberus.localdomain dnsmasq[6118]: ignoring nameserver 127.0.0.1 - local interface Sep 10 20:50:09 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages. Sep 10 20:50:09 cerberus.localdomain php: rc.start_packages: XML error: SYSTEM or PUBLIC, the URI is missing at line 1 in /usr/local/pkg/git.xml Sep 10 20:50:09 cerberus.localdomain php: rc.start_packages: XML error: SYSTEM or PUBLIC, the URI is missing at line 1 in /usr/local/pkg/git.xml Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:13 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:14 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv4 gateway for interface (wan). Sep 10 20:50:19 cerberus.localdomain dhclient[94022]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 10 20:50:21 cerberus.localdomain dhclient[94022]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 10 20:50:23 cerberus.localdomain dhclient[94022]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 10 20:50:27 cerberus.localdomain dhclient[94022]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 10 20:50:36 cerberus.localdomain dhclient[94022]: DHCPREQUEST on vr1 to 192.168.100.1 port 67 Sep 10 20:50:45 cerberus.localdomain dhclient[94022]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 10 20:50:45 cerberus.localdomain dhclient[94022]: DHCPNAK from 96.120.88.245 Sep 10 20:50:45 cerberus.localdomain dhclient[94022]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 1 Sep 10 20:50:45 cerberus.localdomain dhclient[94022]: DHCPOFFER from 96.120.88.245 Sep 10 20:50:45 cerberus.localdomain dhclient: ARPSEND Sep 10 20:50:47 cerberus.localdomain dhclient: ARPCHECK Sep 10 20:50:47 cerberus.localdomain dhclient[94022]: DHCPREQUEST on vr1 to 255.255.255.255 port 67 Sep 10 20:50:47 cerberus.localdomain dhclient[94022]: DHCPACK from 96.120.88.245 Sep 10 20:50:47 cerberus.localdomain dhclient: BOUND Sep 10 20:50:47 cerberus.localdomain dhclient: Starting delete_old_states() Sep 10 20:50:47 cerberus.localdomain dhclient: Comparing IPs: Old: New: 67.x.y.z Sep 10 20:50:47 cerberus.localdomain dhclient: Starting add_new_address() Sep 10 20:50:47 cerberus.localdomain dhclient: ifconfig vr1 inet 67.x.y.z netmask 255.255.252.0 broadcast 255.255.255.255 Sep 10 20:50:47 cerberus.localdomain dhclient: New IP Address (vr1): 67.x.y.z Sep 10 20:50:47 cerberus.localdomain dhclient: New Subnet Mask (vr1): 255.255.252.0 Sep 10 20:50:47 cerberus.localdomain dhclient: New Broadcast Address (vr1): 255.255.255.255 Sep 10 20:50:47 cerberus.localdomain dhclient: New Routers (vr1): 67.x.y.1 Sep 10 20:50:47 cerberus.localdomain dhclient: Adding new routes to interface: vr1 Sep 10 20:50:47 cerberus.localdomain dhclient: /sbin/route add default 67.x.y.1 Sep 10 20:50:47 cerberus.localdomain dhclient: Creating resolv.conf Sep 10 20:50:47 cerberus.localdomain check_reload_status: rc.newwanip starting vr1 Sep 10 20:50:48 cerberus.localdomain dhclient[94022]: bound to 67.x.y.z -- renewal in 89425 seconds. Sep 10 20:50:51 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting vr1. Sep 10 20:50:51 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 67.x.y.z) (interface: wan) (real interface: vr1). Sep 10 20:50:51 cerberus.localdomain php: rc.newwanip: ROUTING: setting default route to 67.x.y.1 Sep 10 20:50:52 cerberus.localdomain apinger: Starting Alarm Pinger, apinger(26451) Sep 10 20:50:57 cerberus.localdomain dnsmasq[6118]: reading /etc/resolv.conf Sep 10 20:50:57 cerberus.localdomain dnsmasq[6118]: using nameserver 75.75.76.76#53 Sep 10 20:50:57 cerberus.localdomain dnsmasq[6118]: using nameserver 75.75.75.75#53 Sep 10 20:50:57 cerberus.localdomain dnsmasq[6118]: using nameserver 2001:558:feed::2#53 Sep 10 20:50:57 cerberus.localdomain dnsmasq[6118]: using nameserver 2001:558:feed::1#53 Sep 10 20:50:57 cerberus.localdomain dnsmasq[6118]: ignoring nameserver 127.0.0.1 - local interface Sep 10 20:50:59 cerberus.localdomain php: rc.newwanip: Resyncing OpenVPN instances for interface WAN. Sep 10 20:51:01 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change 192.168.100.10 -> 67.x.y.z ... Restarting packages. Sep 10 20:51:01 cerberus.localdomain check_reload_status: Starting packages Sep 10 20:51:01 cerberus.localdomain check_reload_status: Reloading filter Sep 10 20:51:07 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages. Sep 10 20:51:07 cerberus.localdomain php: rc.start_packages: XML error: SYSTEM or PUBLIC, the URI is missing at line 1 in /usr/local/pkg/git.xml Sep 10 20:51:07 cerberus.localdomain php: rc.start_packages: XML error: SYSTEM or PUBLIC, the URI is missing at line 1 in /usr/local/pkg/git.xml Sep 10 20:51:11 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
-
From what i see you do not have the use v4 link for v6 connectivity toggle on this WAN.
That would make sure it works as needed on such renewals. -
Sorry. Didn't realize this was a toggle. I can try again and post the results. Only, where do I find this toggle?
-
It's in the interface settings for the WAN interface.
-
I tried the "Use IPv4 connectivity as parent interface" again which is the only thing that sounds correct.
Same results where IPv6 connectivity doesn't work with that setting.
Sep 11 23:00:06 cerberus.localdomain php: rc.newwanipv6: rc.newwanipv6: Informational is starting vr1. Sep 11 23:00:06 cerberus.localdomain php: rc.newwanipv6: rc.newwanipv6: Failed to update wan IPv6, restarting... Sep 11 23:00:06 cerberus.localdomain dhcp6c[17196]: check_exit: exiting
When I uncheck that setting, I get IPv6 connectivity back. Am I missing something/doing something incorrectly?
Razzfazz, are you having luck with this?
-
I haven't tested unplugging my upstream yet, but IPv6 seems to work for me with that checkbox enabled.