Actions
Bug #5948
closed
WAN with DHCPv6 gets stuck in a loop reconfiguring
Start date:
03/03/2016
Due date:
% Done:
0%
Estimated time:
Plus Target Version:
Release Notes:
Affected Version:
2.3
Affected Architecture:
All
Description
I can reproduce this on three boxes, seems to be specific to DHCPv6. In my case it's pulling PD as well.
Log is full of repeats of the same block over and over, here are a couple:
Mar 3 12:46:49 php-fpm 84731 /rc.newwanipv6: ROUTING: setting default route to 198.51.100.1 Mar 3 12:46:49 php-fpm 84731 /rc.newwanipv6: ROUTING: setting IPv6 default route to fe80::290:bff:fe37:a324%vmx0 Mar 3 12:46:49 check_reload_status Reloading filter Mar 3 12:46:49 php-fpm 99791 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:49 php-fpm 99791 /rc.newwanipv6: rc.newwanipv6: No IPv6 address found for interface WAN [wan]. Mar 3 12:46:49 php-fpm 70561 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:49 php-fpm 70561 /rc.newwanipv6: rc.newwanipv6: No IPv6 address found for interface WAN [wan]. Mar 3 12:46:50 php-fpm 99791 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:50 php-fpm 99791 /rc.newwanipv6: rc.newwanipv6: on (IP address: 2001:db8::ffff:87fe) (interface: wan) (real interface: vmx0). Mar 3 12:46:50 xinetd 22214 Starting reconfiguration Mar 3 12:46:50 xinetd 22214 Swapping defaults Mar 3 12:46:50 xinetd 22214 readjusting service 6969-udp Mar 3 12:46:50 xinetd 22214 Reconfigured: new=0 old=1 dropped=0 (services) Mar 3 12:46:51 php-fpm 99791 /rc.newwanipv6: ROUTING: setting default route to 198.51.100.1 Mar 3 12:46:51 php-fpm 99791 /rc.newwanipv6: ROUTING: setting IPv6 default route to fe80::290:bff:fe37:a324%vmx0 Mar 3 12:46:51 check_reload_status Reloading filter Mar 3 12:46:51 php-fpm 70561 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:51 php-fpm 70561 /rc.newwanipv6: rc.newwanipv6: No IPv6 address found for interface WAN [wan]. Mar 3 12:46:51 php-fpm 84731 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:51 php-fpm 84731 /rc.newwanipv6: rc.newwanipv6: No IPv6 address found for interface WAN [wan]. Mar 3 12:46:53 xinetd 22214 Starting reconfiguration Mar 3 12:46:53 xinetd 22214 Swapping defaults Mar 3 12:46:53 xinetd 22214 readjusting service 6969-udp Mar 3 12:46:53 xinetd 22214 Reconfigured: new=0 old=1 dropped=0 (services) Mar 3 12:46:53 php-fpm 84731 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:53 php-fpm 84731 /rc.newwanipv6: rc.newwanipv6: on (IP address: 2001:db8::ffff:87fe) (interface: wan) (real interface: vmx0). Mar 3 12:46:54 php-fpm 84731 /rc.newwanipv6: ROUTING: setting default route to 198.51.100.1 Mar 3 12:46:54 php-fpm 84731 /rc.newwanipv6: ROUTING: setting IPv6 default route to fe80::290:bff:fe37:a324%vmx0 Mar 3 12:46:54 check_reload_status Reloading filter Mar 3 12:46:54 php-fpm 70561 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:54 php-fpm 70561 /rc.newwanipv6: rc.newwanipv6: No IPv6 address found for interface WAN [wan]. Mar 3 12:46:54 php-fpm 99791 /rc.newwanipv6: rc.newwanipv6: Info: starting on vmx0. Mar 3 12:46:54 php-fpm 99791 /rc.newwanipv6: rc.newwanipv6: No IPv6 address found for interface WAN [wan]. Mar 3 12:46:55 xinetd 22214 Starting reconfiguration Mar 3 12:46:55 xinetd 22214 Swapping defaults Mar 3 12:46:55 xinetd 22214 readjusting service 6969-udp Mar 3 12:46:55 xinetd 22214 Reconfigured: new=0 old=1 dropped=0 (services)
dpinger is also being restarted, as are radvd, dnsmasq/unbound, and so on.
DHCP log from a couple restarts:
Mar 3 12:49:34 dhcp6c 41883 restarting Mar 3 12:49:34 dhcp6c 41883 status code: success Mar 3 12:49:34 dhcp6c 41883 status code: success Mar 3 12:49:36 dhcp6c 41883 T1(2250) and/or T2(3600) is locally determined Mar 3 12:49:36 dhcp6c 41883 T1(2250) and/or T2(3600) is locally determined Mar 3 12:49:37 dhcpd Internet Systems Consortium DHCP Server 4.3.3-P1 Mar 3 12:49:37 dhcpd Copyright 2004-2016 Internet Systems Consortium. Mar 3 12:49:37 dhcpd All rights reserved. Mar 3 12:49:37 dhcpd For info, please visit https://www.isc.org/software/dhcp/ Mar 3 12:49:37 dhcpd Config file: /etc/dhcpdv6.conf Mar 3 12:49:37 dhcpd Database file: /var/db/dhcpd6.leases Mar 3 12:49:37 dhcpd PID file: /var/run/dhcpdv6.pid Mar 3 12:49:37 dhcpd Internet Systems Consortium DHCP Server 4.3.3-P1 Mar 3 12:49:37 dhcpd Copyright 2004-2016 Internet Systems Consortium. Mar 3 12:49:37 dhcpd All rights reserved. Mar 3 12:49:37 dhcpd For info, please visit https://www.isc.org/software/dhcp/ Mar 3 12:49:37 dhcpd Wrote 0 deleted host decls to leases file. Mar 3 12:49:37 dhcpd Wrote 0 new dynamic host decls to leases file. Mar 3 12:49:37 dhcpd Wrote 2 NA, 0 TA, 0 PD leases to lease file. Mar 3 12:49:37 dhcpd Bound to *:547 Mar 3 12:49:37 dhcpd Listening on Socket/5/vmx1/2001:db8:1:ef00::/64 Mar 3 12:49:37 dhcpd Sending on Socket/5/vmx1/2001:db8:1:ef00::/64 Mar 3 12:49:37 dhcpd Server starting service. Mar 3 12:49:37 dhcp6c 41883 restarting Mar 3 12:49:37 dhcp6c 41883 status code: success Mar 3 12:49:37 dhcp6c 41883 status code: success Mar 3 12:49:38 dhcp6c 41883 T1(2250) and/or T2(3600) is locally determined Mar 3 12:49:38 dhcp6c 41883 T1(2250) and/or T2(3600) is locally determined Mar 3 12:49:40 dhcpd Internet Systems Consortium DHCP Server 4.3.3-P1 Mar 3 12:49:40 dhcpd Copyright 2004-2016 Internet Systems Consortium. Mar 3 12:49:40 dhcpd All rights reserved. Mar 3 12:49:40 dhcpd For info, please visit https://www.isc.org/software/dhcp/ Mar 3 12:49:40 dhcpd Config file: /etc/dhcpdv6.conf Mar 3 12:49:40 dhcpd Database file: /var/db/dhcpd6.leases Mar 3 12:49:40 dhcpd PID file: /var/run/dhcpdv6.pid Mar 3 12:49:40 dhcpd Internet Systems Consortium DHCP Server 4.3.3-P1 Mar 3 12:49:40 dhcpd Copyright 2004-2016 Internet Systems Consortium. Mar 3 12:49:40 dhcpd All rights reserved. Mar 3 12:49:40 dhcpd For info, please visit https://www.isc.org/software/dhcp/ Mar 3 12:49:40 dhcpd Wrote 0 deleted host decls to leases file. Mar 3 12:49:40 dhcpd Wrote 0 new dynamic host decls to leases file. Mar 3 12:49:40 dhcpd Wrote 2 NA, 0 TA, 0 PD leases to lease file. Mar 3 12:49:40 dhcpd Bound to *:547 Mar 3 12:49:40 dhcpd Listening on Socket/5/vmx1/2001:db8:1:ef00::/64 Mar 3 12:49:40 dhcpd Sending on Socket/5/vmx1/2001:db8:1:ef00::/64 Mar 3 12:49:40 dhcpd Server starting service. Mar 3 12:49:40 dhcp6c 41883 restarting Mar 3 12:49:40 dhcp6c 41883 status code: success Mar 3 12:49:40 dhcp6c 41883 status code: success Mar 3 12:49:42 dhcp6c 41883 T1(2250) and/or T2(3600) is locally determined Mar 3 12:49:42 dhcp6c 41883 T1(2250) and/or T2(3600) is locally determined Mar 3 12:49:43 dhcpd Internet Systems Consortium DHCP Server 4.3.3-P1 Mar 3 12:49:43 dhcpd Copyright 2004-2016 Internet Systems Consortium. Mar 3 12:49:43 dhcpd All rights reserved. Mar 3 12:49:43 dhcpd For info, please visit https://www.isc.org/software/dhcp/ Mar 3 12:49:43 dhcpd Config file: /etc/dhcpdv6.conf Mar 3 12:49:43 dhcpd Database file: /var/db/dhcpd6.leases Mar 3 12:49:43 dhcpd PID file: /var/run/dhcpdv6.pid Mar 3 12:49:43 dhcpd Internet Systems Consortium DHCP Server 4.3.3-P1 Mar 3 12:49:43 dhcpd Copyright 2004-2016 Internet Systems Consortium. Mar 3 12:49:43 dhcpd All rights reserved. Mar 3 12:49:43 dhcpd For info, please visit https://www.isc.org/software/dhcp/ Mar 3 12:49:43 dhcpd Wrote 0 deleted host decls to leases file. Mar 3 12:49:43 dhcpd Wrote 0 new dynamic host decls to leases file. Mar 3 12:49:43 dhcpd Wrote 2 NA, 0 TA, 0 PD leases to lease file. Mar 3 12:49:43 dhcpd Bound to *:547 Mar 3 12:49:43 dhcpd Listening on Socket/5/vmx1/2001:db8:1:ef00::/64 Mar 3 12:49:43 dhcpd Sending on Socket/5/vmx1/2001:db8:1:ef00::/64 Mar 3 12:49:43 dhcpd Server starting service. Mar 3 12:49:43 dhcp6c 41883 restarting
Seems like it might possibly be related to some work done on DHCPv6 recently. Static IPv6 is unaffected.
Updated by Chris Buechler over 8 years ago
- Assignee set to Chris Buechler
I was looking at this earlier.
Updated by Chris Buechler over 8 years ago
- Status changed from Confirmed to Resolved
this is fixed, re-opened #5945 after reverting that change.
Actions