RADVD and IPv6 Killed by Modem Reboot



  • I'm running 2.1-RC1 (i386) built on Sat Aug 24 11:30:48 EDT 2013. I have comcast. Their IPv6 is via DHCP6-PD.

    For whatever reason, my modem rebooted. In normal operation, the pfsense WAN gets a /128 with a 2001: prefix and the LAN get /64 2601: prefix. After this reboot event, both are gone and RADVD is gone from the services page. IPv6 will not automatically come back at this point without some user intervention.

    During the reboot, the modem acted as a DHCP (IPv4) server temporarily. It does this to provide connectivity to the modem's status/diag page. It gave pfsense an address of 192.168.100.10

    It doesn't seem to offer any IPv6 connectivity. It keeps a 30 second DHCP lease time so that when normal connectivity is restored, the router will attempt to renew and then get connectivity from Comcast's DHCP server.

    As an additional note, it looks like the reboot causes the link to go down. When normal connectivity is restored, the link remains up.

    I setup remote syslogging so I can provide any relevant logs from this event. I'm not sure what's relevant though.

    Here's RADVD's final words:

    Aug 27 14:24:50 cerberus.localdomain php: rc.linkup: Shutting down Router Advertisment daemon cleanly
    Aug 27 14:24:50 cerberus.localdomain radvd[37768]: Exiting, sigterm or sigint received.
    Aug 27 14:24:50 cerberus.localdomain radvd[37768]: sending stop adverts
    Aug 27 14:24:50 cerberus.localdomain radvd[37768]: removing /var/run/radvd.pid
    

    To me it seems the steps to reproduce this are as follows:
    Create two networks. One with DHCP6-PD and one without any IPv6
    Have pfsense connect to the DHCP6-PD one
    Bring down the link and connect it to the one without IPv6
    Reestablish connectivity to the DHCP6-PD without affecting the link and remove the one without IPv6



  • Yeah, I see the same thing; see here.



  • Somehow the ticket for DHCPv6-PD issues was recently closed anyway: https://redmine.pfsense.org/issues/2919



  • I guess a possible solution would be to renew (if it exists) or try and re-establish (if it doesn't) IPv6 connectivity any time the WAN IPv4 address changes?



  • Well that's discouraging  :-. In any case, here's the output from the logfile. The lack of ability to reattempt IPv6 seems to be due to something in rc.linkup. It's what kills RADVD according to the logs.

    Aug 27 14:24:19 cerberus.localdomain check_reload_status: Linkup starting vr1
    Aug 27 14:24:19 cerberus.localdomain kernel: vr1: link state changed to DOWN
    Aug 27 14:24:24 cerberus.localdomain php: rc.linkup: DEVD Ethernet detached event for wan
    Aug 27 14:24:24 cerberus.localdomain dhclient[9182]: connection closed
    Aug 27 14:24:24 cerberus.localdomain dhclient[9182]: exiting.
    Aug 27 14:24:28 cerberus.localdomain php: rc.linkup: Clearing states to old gateway 67.x.y.1.
    Aug 27 14:24:32 cerberus.localdomain kernel: arpresolve: can't allocate llinfo for 67.x.y.1
    Aug 27 14:24:36 cerberus.localdomain check_reload_status: Linkup starting vr1
    Aug 27 14:24:36 cerberus.localdomain kernel: vr1: link state changed to UP
    Aug 27 14:24:39 cerberus.localdomain check_reload_status: Linkup starting vr1
    Aug 27 14:24:39 cerberus.localdomain kernel: vr1: link state changed to DOWN
    Aug 27 14:24:41 cerberus.localdomain php: rc.linkup: DEVD Ethernet attached event for wan
    Aug 27 14:24:41 cerberus.localdomain php: rc.linkup: HOTPLUG: Configuring interface wan
    Aug 27 14:24:41 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'
    Aug 27 14:24:41 cerberus.localdomain check_reload_status: Linkup starting vr1
    Aug 27 14:24:41 cerberus.localdomain kernel: vr1: link state changed to UP
    Aug 27 14:24:41 cerberus.localdomain dhclient: PREINIT
    Aug 27 14:24:41 cerberus.localdomain dhclient: Starting delete_old_states()
    Aug 27 14:24:41 cerberus.localdomain dhclient: Comparing IPs: Old:  New:
    Aug 27 14:24:41 cerberus.localdomain dhclient[8440]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Aug 27 14:24:42 cerberus.localdomain dhclient[8440]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Aug 27 14:24:42 cerberus.localdomain kernel: arpresolve: can't allocate llinfo for 67.x.y.1
    Aug 27 14:24:44 cerberus.localdomain php: rc.linkup: DEVD Ethernet detached event for wan
    Aug 27 14:24:44 cerberus.localdomain dhclient[8988]: connection closed
    Aug 27 14:24:44 cerberus.localdomain dhclient[8988]: exiting.
    Aug 27 14:24:44 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 '15', the output was ''
    Aug 27 14:24:44 cerberus.localdomain php: rc.linkup: Accept router advertisements on interface vr1
    Aug 27 14:24:46 cerberus.localdomain php: rc.linkup: DEVD Ethernet attached event for wan
    Aug 27 14:24:46 cerberus.localdomain php: rc.linkup: HOTPLUG: Configuring interface wan
    Aug 27 14:24:46 cerberus.localdomain dnsmasq[36122]: exiting on receipt of SIGTERM
    Aug 27 14:24:47 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'
    Aug 27 14:24:47 cerberus.localdomain dhclient: PREINIT
    Aug 27 14:24:47 cerberus.localdomain dhclient: Starting delete_old_states()
    Aug 27 14:24:47 cerberus.localdomain dhclient: Comparing IPs: Old:  New:
    Aug 27 14:24:47 cerberus.localdomain dhclient[14008]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Aug 27 14:24:47 cerberus.localdomain dhclient[14008]: DHCPNAK from 192.168.100.1
    Aug 27 14:24:47 cerberus.localdomain dhclient[14008]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 1
    Aug 27 14:24:47 cerberus.localdomain dnsmasq[16494]: started, version 2.66 cachesize 10000
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: compile time options: IPv6 GNU-getopt no-DBus i18n IDN DHCP DHCPv6 no-Lua TFTP no-conntrack no-ipset auth
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: reading /etc/resolv.conf
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: using nameserver 75.75.76.76#53
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: using nameserver 75.75.75.75#53
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: using nameserver 2001:558:feed::2#53
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: using nameserver 2001:558:feed::1#53
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: ignoring nameserver 127.0.0.1 - local interface
    Aug 27 14:24:48 cerberus.localdomain dnsmasq[16494]: read /etc/hosts - 2 addresses
    Aug 27 14:24:48 cerberus.localdomain dhclient[14008]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 1
    Aug 27 14:24:49 cerberus.localdomain dhclient[14008]: DHCPOFFER from 192.168.100.1
    Aug 27 14:24:49 cerberus.localdomain dhclient: ARPSEND
    Aug 27 14:24:49 cerberus.localdomain dhclient[14008]: DHCPOFFER from 192.168.100.1
    Aug 27 14:24:49 cerberus.localdomain dhclient[14008]: DHCPOFFER already seen.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: All rights reserved.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: All rights reserved.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Wrote 0 deleted host decls to leases file.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Wrote 0 new dynamic host decls to leases file.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Wrote 3 leases to leases file.
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Listening on BPF/vr0/zz:xx:yy:aa:bb:cc/192.168.112.0/24
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Sending on   BPF/vr0/zz:xx:yy:aa:bb:cc/192.168.112.0/24
    Aug 27 14:24:49 cerberus.localdomain dhcpd: Sending on   Socket/fallback/fallback-net
    Aug 27 14:24:50 cerberus.localdomain php: rc.linkup: Shutting down Router Advertisment daemon cleanly
    Aug 27 14:24:50 cerberus.localdomain radvd[37768]: Exiting, sigterm or sigint received.
    Aug 27 14:24:50 cerberus.localdomain radvd[37768]: sending stop adverts
    Aug 27 14:24:50 cerberus.localdomain radvd[37768]: removing /var/run/radvd.pid
    Aug 27 14:24:51 cerberus.localdomain check_reload_status: updating dyndns wan
    Aug 27 14:24:51 cerberus.localdomain dhclient: ARPCHECK
    Aug 27 14:24:51 cerberus.localdomain dhclient[14008]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Aug 27 14:24:51 cerberus.localdomain dhclient[14008]: DHCPACK from 192.168.100.1
    Aug 27 14:24:51 cerberus.localdomain dhclient: BOUND
    Aug 27 14:24:51 cerberus.localdomain dhclient: Starting delete_old_states()
    Aug 27 14:24:51 cerberus.localdomain dhclient: Comparing IPs: Old:  New: 192.168.100.10
    Aug 27 14:24:51 cerberus.localdomain dhclient: Starting add_new_address()
    Aug 27 14:24:51 cerberus.localdomain dhclient: ifconfig vr1 inet 192.168.100.10 netmask 255.255.255.0 broadcast 192.168.100.255
    Aug 27 14:24:51 cerberus.localdomain dhclient: New IP Address (vr1): 192.168.100.10
    Aug 27 14:24:51 cerberus.localdomain dhclient: New Subnet Mask (vr1): 255.255.255.0
    Aug 27 14:24:51 cerberus.localdomain dhclient: New Broadcast Address (vr1): 192.168.100.255
    Aug 27 14:24:51 cerberus.localdomain dhclient: New Routers (vr1): 192.168.100.1
    Aug 27 14:24:51 cerberus.localdomain dhclient: Adding new routes to interface: vr1
    Aug 27 14:24:51 cerberus.localdomain dhclient: /sbin/route add default 192.168.100.1
    Aug 27 14:24:51 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:24:51 cerberus.localdomain dhclient[14008]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:24:51 cerberus.localdomain php: rc.linkup: Accept router advertisements on interface vr1
    Aug 27 14:24:51 cerberus.localdomain check_reload_status: rc.newwanip starting vr1
    Aug 27 14:24:52 cerberus.localdomain php: rc.linkup: ROUTING: setting default route to 192.168.100.1
    Aug 27 14:24:54 cerberus.localdomain dnsmasq[16494]: exiting on receipt of SIGTERM
    Aug 27 14:24:55 cerberus.localdomain kernel: ovpns2: link state changed to DOWN
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: started, version 2.66 cachesize 10000
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: compile time options: IPv6 GNU-getopt no-DBus i18n IDN DHCP DHCPv6 no-Lua TFTP no-conntrack no-ipset auth
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: reading /etc/resolv.conf
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: using nameserver 75.75.76.76#53
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: using nameserver 75.75.75.75#53
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: using nameserver 2001:558:feed::2#53
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: using nameserver 2001:558:feed::1#53
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: ignoring nameserver 127.0.0.1 - local interface
    Aug 27 14:24:55 cerberus.localdomain dnsmasq[34026]: read /etc/hosts - 2 addresses
    Aug 27 14:24:55 cerberus.localdomain check_reload_status: Reloading filter
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium.
    Aug 27 14:24:56 cerberus.localdomain dhcpd: All rights reserved.
    Aug 27 14:24:56 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Internet Systems Consortium DHCP Server 4.2.5-P1
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Copyright 2004-2013 Internet Systems Consortium.
    Aug 27 14:24:56 cerberus.localdomain dhcpd: All rights reserved.
    Aug 27 14:24:56 cerberus.localdomain dhcpd: For info, please visit https://www.isc.org/software/dhcp/
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Wrote 0 deleted host decls to leases file.
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Wrote 0 new dynamic host decls to leases file.
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Wrote 3 leases to leases file.
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Listening on BPF/vr0/zz:xx:yy:aa:bb:cc/192.168.112.0/24
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Sending on   BPF/vr0/zz:xx:yy:aa:bb:cc/192.168.112.0/24
    Aug 27 14:24:56 cerberus.localdomain dhcpd: Sending on   Socket/fallback/fallback-net
    Aug 27 14:24:57 cerberus.localdomain dhcp6c[20345]: client6_timo: no responses were received
    Aug 27 14:24:58 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting vr1.
    Aug 27 14:24:58 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 192.168.100.10) (interface: wan) (real interface: vr1).
    Aug 27 14:24:58 cerberus.localdomain php: rc.newwanip: ROUTING: setting default route to 192.168.100.1
    Aug 27 14:24:58 cerberus.localdomain dhcp6c[20345]: client6_timo: no responses were received
    Aug 27 14:24:58 cerberus.localdomain dhcp6c[20345]: check_exit: exiting
    Aug 27 14:24:59 cerberus.localdomain apinger: Starting Alarm Pinger, apinger(39118)
    Aug 27 14:24:59 cerberus.localdomain apinger: No usable targets found, exiting
    Aug 27 14:25:06 cerberus.localdomain php: rc.newwanip: Resyncing OpenVPN instances for interface WAN.
    Aug 27 14:25:06 cerberus.localdomain kernel: ovpns1: link state changed to DOWN
    Aug 27 14:25:06 cerberus.localdomain check_reload_status: Reloading filter
    Aug 27 14:25:07 cerberus.localdomain kernel: ovpns1: link state changed to UP
    Aug 27 14:25:07 cerberus.localdomain kernel: ovpns2: link state changed to UP
    Aug 27 14:25:07 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns1
    Aug 27 14:25:07 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns2
    Aug 27 14:25:07 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
    Aug 27 14:25:09 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change 67.x.y.z ->  192.168.100.10 ... Restarting packages.
    Aug 27 14:25:09 cerberus.localdomain check_reload_status: Starting packages
    Aug 27 14:25:10 cerberus.localdomain dnsmasq[34026]: reading /etc/resolv.conf
    Aug 27 14:25:10 cerberus.localdomain dnsmasq[34026]: using nameserver 2001:558:feed::2#53
    Aug 27 14:25:10 cerberus.localdomain dnsmasq[34026]: using nameserver 2001:558:feed::1#53
    Aug 27 14:25:10 cerberus.localdomain dnsmasq[34026]: ignoring nameserver 127.0.0.1 - local interface
    Aug 27 14:25:17 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns1.
    Aug 27 14:25:17 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.251.1) (interface: ) (real interface: ovpns1).
    Aug 27 14:25:17 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns2.
    Aug 27 14:25:17 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.249.1) (interface: ) (real interface: ovpns2).
    Aug 27 14:25:17 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change  ->  172.29.251.1 ... Restarting packages.
    Aug 27 14:25:17 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change  ->  172.29.249.1 ... Restarting packages.
    Aug 27 14:25:20 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages.
    Aug 27 14:25:21 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:25:21 cerberus.localdomain dhclient[28258]: DHCPACK from 192.168.100.1
    Aug 27 14:25:21 cerberus.localdomain dhclient: RENEW
    Aug 27 14:25:21 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:25:21 cerberus.localdomain dhclient[28258]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:25:24 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
    Aug 27 14:25:28 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages.
    Aug 27 14:25:28 cerberus.localdomain kernel: pid 59109 (php), uid 0, was killed: out of swap space
    Aug 27 14:25:31 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
    Aug 27 14:25:35 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
    Aug 27 14:25:51 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:25:51 cerberus.localdomain dhclient[28258]: DHCPACK from 192.168.100.1
    Aug 27 14:25:51 cerberus.localdomain dhclient: RENEW
    Aug 27 14:25:51 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:25:51 cerberus.localdomain dhclient[28258]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:26:21 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:26:21 cerberus.localdomain dhclient[28258]: DHCPACK from 192.168.100.1
    Aug 27 14:26:21 cerberus.localdomain dhclient: RENEW
    Aug 27 14:26:21 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:26:21 cerberus.localdomain dhclient[28258]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:26:34 cerberus.localdomain kernel: cannot forward src fe80:1::96de:80ff:fe76:b365, dst 2601:9:pfsense-WAN::, nxt 58, rcvif vr0, outif vr1
    Aug 27 14:26:51 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:26:51 cerberus.localdomain dhclient[28258]: DHCPACK from 192.168.100.1
    Aug 27 14:26:51 cerberus.localdomain dhclient: RENEW
    Aug 27 14:26:51 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:26:51 cerberus.localdomain dhclient[28258]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:27:21 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:27:21 cerberus.localdomain dhclient[28258]: DHCPACK from 192.168.100.1
    Aug 27 14:27:21 cerberus.localdomain dhclient: RENEW
    Aug 27 14:27:21 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:27:21 cerberus.localdomain dhclient[28258]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:27:51 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:27:51 cerberus.localdomain dhclient[28258]: DHCPACK from 192.168.100.1
    Aug 27 14:27:51 cerberus.localdomain dhclient: RENEW
    Aug 27 14:27:51 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:27:51 cerberus.localdomain dhclient[28258]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:28:21 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:28:21 cerberus.localdomain dhclient[28258]: DHCPACK from 192.168.100.1
    Aug 27 14:28:21 cerberus.localdomain dhclient: RENEW
    Aug 27 14:28:21 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:28:21 cerberus.localdomain dhclient[28258]: bound to 192.168.100.10 -- renewal in 30 seconds.
    Aug 27 14:28:51 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:28:52 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:28:54 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:28:59 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:29:04 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:29:11 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 192.168.100.1 port 67
    Aug 27 14:29:19 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Aug 27 14:29:20 cerberus.localdomain dhclient[28258]: DHCPNAK from 96.120.88.245
    Aug 27 14:29:20 cerberus.localdomain dhclient[28258]: DHCPDISCOVER on vr1 to 255.255.255.255 port 67 interval 2
    Aug 27 14:29:20 cerberus.localdomain dhclient[28258]: DHCPOFFER from 96.120.88.245
    Aug 27 14:29:20 cerberus.localdomain dhclient: ARPSEND
    Aug 27 14:29:22 cerberus.localdomain dhclient: ARPCHECK
    Aug 27 14:29:22 cerberus.localdomain dhclient[28258]: DHCPREQUEST on vr1 to 255.255.255.255 port 67
    Aug 27 14:29:22 cerberus.localdomain dhclient[28258]: DHCPACK from 96.120.88.245
    Aug 27 14:29:22 cerberus.localdomain dhclient: BOUND
    Aug 27 14:29:22 cerberus.localdomain dhclient: Starting delete_old_states()
    Aug 27 14:29:22 cerberus.localdomain dhclient: Comparing IPs: Old:  New: 67.x.y.z
    Aug 27 14:29:22 cerberus.localdomain dhclient: Starting add_new_address()
    Aug 27 14:29:22 cerberus.localdomain dhclient: ifconfig vr1 inet 67.x.y.z netmask 255.255.252.0 broadcast 255.255.255.255
    Aug 27 14:29:22 cerberus.localdomain dhclient: New IP Address (vr1): 67.x.y.z
    Aug 27 14:29:22 cerberus.localdomain dhclient: New Subnet Mask (vr1): 255.255.252.0
    Aug 27 14:29:22 cerberus.localdomain dhclient: New Broadcast Address (vr1): 255.255.255.255
    Aug 27 14:29:22 cerberus.localdomain dhclient: New Routers (vr1): 67.x.y.1
    Aug 27 14:29:22 cerberus.localdomain dhclient: Adding new routes to interface: vr1
    Aug 27 14:29:22 cerberus.localdomain dhclient: /sbin/route add default 67.x.y.1
    Aug 27 14:29:22 cerberus.localdomain dhclient: Creating resolv.conf
    Aug 27 14:29:22 cerberus.localdomain check_reload_status: rc.newwanip starting vr1
    Aug 27 14:29:23 cerberus.localdomain dhclient[28258]: bound to 67.x.y.z -- renewal in 161405 seconds.
    Aug 27 14:29:27 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting vr1.
    Aug 27 14:29:27 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 67.x.y.z) (interface: wan) (real interface: vr1).
    Aug 27 14:29:27 cerberus.localdomain php: rc.newwanip: ROUTING: setting default route to 67.x.y.1
    Aug 27 14:29:28 cerberus.localdomain apinger: Starting Alarm Pinger, apinger(15848)
    Aug 27 14:29:28 cerberus.localdomain apinger: No usable targets found, exiting
    Aug 27 14:29:33 cerberus.localdomain dnsmasq[34026]: reading /etc/resolv.conf
    Aug 27 14:29:33 cerberus.localdomain dnsmasq[34026]: using nameserver 75.75.76.76#53
    Aug 27 14:29:33 cerberus.localdomain dnsmasq[34026]: using nameserver 75.75.75.75#53
    Aug 27 14:29:33 cerberus.localdomain dnsmasq[34026]: using nameserver 2001:558:feed::2#53
    Aug 27 14:29:33 cerberus.localdomain dnsmasq[34026]: using nameserver 2001:558:feed::1#53
    Aug 27 14:29:33 cerberus.localdomain dnsmasq[34026]: ignoring nameserver 127.0.0.1 - local interface
    Aug 27 14:29:34 cerberus.localdomain php: rc.newwanip: Resyncing OpenVPN instances for interface WAN.
    Aug 27 14:29:34 cerberus.localdomain kernel: ovpns1: link state changed to DOWN
    Aug 27 14:29:34 cerberus.localdomain check_reload_status: Reloading filter
    Aug 27 14:29:35 cerberus.localdomain kernel: ovpns2: link state changed to DOWN
    Aug 27 14:29:35 cerberus.localdomain kernel: ovpns1: link state changed to UP
    Aug 27 14:29:35 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns1
    Aug 27 14:29:35 cerberus.localdomain kernel: ovpns2: link state changed to UP
    Aug 27 14:29:35 cerberus.localdomain check_reload_status: rc.newwanip starting ovpns2
    Aug 27 14:29:37 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change 192.168.100.10 ->  67.x.y.z ... Restarting packages.
    Aug 27 14:29:37 cerberus.localdomain check_reload_status: Starting packages
    Aug 27 14:29:44 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns1.
    Aug 27 14:29:44 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.251.1) (interface: ) (real interface: ovpns1).
    Aug 27 14:29:44 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting ovpns2.
    Aug 27 14:29:44 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 172.29.249.1) (interface: ) (real interface: ovpns2).
    Aug 27 14:29:44 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change  ->  172.29.251.1 ... Restarting packages.
    Aug 27 14:29:44 cerberus.localdomain php: rc.newwanip: pfSense package system has detected an ip change  ->  172.29.249.1 ... Restarting packages.
    Aug 27 14:29:47 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages.
    Aug 27 14:29:51 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
    Aug 27 14:29:55 cerberus.localdomain php: rc.start_packages: Restarting/Starting all packages.
    Aug 27 14:29:59 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
    Aug 27 14:30:03 cerberus.localdomain php: rc.filter_configure_sync: Could not find IPv6 gateway for interface(wan).
    
    


  • 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.



  • @darkcrucible:

    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.



  • Interesting. I'm getting some new hardware so I'll test a clean install of pfsense soon. Meanwhile, the following is the logs relating to turning on the "Use IPv4 connectivity as parent interface" option.

    Sep 12 09:34:14 cerberus.localdomain dhcp6c[6090]: client6_recvreply: status code: success
    Sep 12 09:34:16 cerberus.localdomain php: rc.newwanipv6: rc.newwanipv6: Informational is starting vr1.
    Sep 12 09:34:16 cerberus.localdomain php: rc.newwanipv6: rc.newwanipv6: Failed to update wan IPv6, restarting...
    Sep 12 09:34:17 cerberus.localdomain dhcp6c[6090]: client6_recvreply: status code: success
    Sep 12 09:34:18 cerberus.localdomain php: rc.newwanipv6: rc.newwanipv6: Informational is starting vr1.
    Sep 12 09:34:18 cerberus.localdomain php: rc.newwanipv6: rc.newwanipv6: Failed to update wan IPv6, restarting...
    Sep 12 09:34:18 cerberus.localdomain dhcp6c[6090]: check_exit: exiting
    Sep 12 09:34:18 cerberus.localdomain php: /interfaces.php: The command '/sbin/ifconfig 'vr1' inet  delete' returned exit code '1', the output was 'ifconfig: ioctl (SIOCDIFADDR): Can't assign requested address'
    Sep 12 09:34:18 cerberus.localdomain dhcp6c[61681]: dhcp6_ctl_authinit: failed to open /usr/local/etc/dhcp6cctlkey: No such file or directory
    Sep 12 09:34:18 cerberus.localdomain dhcp6c[61681]: client6_init: failed initialize control message authentication
    Sep 12 09:34:18 cerberus.localdomain dhcp6c[61681]: client6_init: skip opening control port
    Sep 12 09:34:18 cerberus.localdomain rtsold: Starting dhcp6 client for interface wan(vr1)
    Sep 12 09:34:24 cerberus.localdomain php: rc.newwanip: rc.newwanip: Informational is starting vr1.
    Sep 12 09:34:24 cerberus.localdomain php: rc.newwanip: rc.newwanip: on (IP address: 67.x.y.z) (interface: wan) (real interface: vr1).
    Sep 12 09:34:24 cerberus.localdomain php: rc.newwanip: Accept router advertisements on interface vr1
    Sep 12 09:34:24 cerberus.localdomain php: rc.newwanip: ROUTING: setting default route to 67.x.y.1
    Sep 12 09:34:24 cerberus.localdomain php: rc.newwanip: ROUTING: setting IPv6 default route to fe80::201:5cff:fe62:c446%vr1
    Sep 12 09:34:24 cerberus.localdomain php: rc.newwanip: Removing static route for monitor fe80::201:5cff:fe62:c446%vr1 and adding a new route through fe80::201:5cff:fe62:c446
    Sep 12 09:34:24 cerberus.localdomain apinger: SIGHUP received, reloading configuration.
    Sep 12 09:34:25 cerberus.localdomain php: /interfaces.php: The command '/usr/local/sbin/dhcpd -6 -user dhcpd -group _dhcp -chroot /var/dhcpd -cf /etc/dhcpdv6.conf -pf /var/run/dhcpdv6.pid vr0' returned exit code '1', the output was 'Internet Systems Consortium DHCP Server 4.2.5-P1 Copyright 2004-2013 Internet Systems Consortium. All rights reserved. For info, please visit https://www.isc.org/software/dhcp/ Wrote 0 leases to leases file.  No subnet6 declaration for vr0 (fe80:1::1:1). ** Ignoring requests on vr0.  If this is not what    you want, please write a subnet6 declaration    in your dhcpd.conf file for the network segment    to which interface vr0 is attached. **   Not configured to listen on any interfaces!  If you did not get this software from ftp.isc.org, please get the latest from ftp.isc.org and install that before requesting help.  If you did get this software from ftp.isc.org and have not yet read the README, please read it before requesting help. If you intend to request help from the dhcp-server@isc.org mail
    Sep 12 09:34:25 cerberus.localdomain radvd[42947]: attempting to reread config file
    Sep 12 09:34:25 cerberus.localdomain radvd[42947]: resuming normal operation
    Sep 12 09:34:25 cerberus.localdomain check_reload_status: updating dyndns wan
    Sep 12 09:34:25 cerberus.localdomain dhcp6c[61907]: check_exit: exiting
    Sep 12 09:34:26 cerberus.localdomain dhcp6c[73523]: dhcp6_ctl_authinit: failed to open /usr/local/etc/dhcp6cctlkey: No such file or directory
    Sep 12 09:34:26 cerberus.localdomain dhcp6c[73523]: client6_init: failed initialize control message authentication
    Sep 12 09:34:26 cerberus.localdomain dhcp6c[73523]: client6_init: skip opening control port
    Sep 12 09:34:27 cerberus.localdomain rtsold: Starting dhcp6 client for interface wan(vr1)
    Sep 12 09:34:27 cerberus.localdomain php: /interfaces.php: Removing static route for monitor fe80::201:5cff:fe62:c446%vr1 and adding a new route through fe80::201:5cff:fe62:c446
    Sep 12 09:34:27 cerberus.localdomain apinger: SIGHUP received, reloading configuration.
    


  • BTW, I tested the "Use IPv4 connectivity as parent interface" option. I was able to retain IPv6 connectivity. The only issue I had with it is that enabling it seemed to require a reboot. Aside from that, so far so good!

    Thanks a lot for this fix.  :) :) :)


Log in to reply