dhcpcd-discuss

Re: DHCPv6 Rebind

Roy Marples

Thu May 09 19:03:05 2019

Hi Shweta

On 09/05/2019 17:45, Shweta Kalyani wrote:
Hi Roy,

I have a dhcpv6 client running which has got an IPv6 address from the server.

What dhcpcd version is this please?

On rebooting, dhcpcd is trying to rebind to the previously allocated address. In pcap, I see the rebind6 request with rebind6 response coming in within the same second.
Dhcpcd however seems to be timing out on the rebind request ~ approx 25 secs
Please see the following log:
May 09 15:57:10 [27685]: eth0: executing `/libexec/dhcpcd-run-hooks' PREINIT
May 09 15:57:10 [27685]: script_runreason: /libexec/dhcpcd-run-hooks: WEXITSTATUS 127
May 09 15:57:10 [27685]: eth0: carrier acquired
May 09 15:57:10 [27685]: eth0: executing `/etc/conf/bin/dhcpcd-up' CARRIER
May 09 15:57:10 [27685]: eth0: IAID 68:16:d5:73
May 09 15:57:10 [27685]: eth1: delaying IPv4 for 0.3 seconds
May 09 15:57:11 [27685]: eth1: using ClientID 01:54:39:68:16:d5:74
May 09 15:57:11 [27685]: eth1: soliciting a DHCP lease
May 09 15:57:11 [27685]: eth1: sending DISCOVER (xid 0x8266886d), next in 4.3 seconds
May 09 15:57:11 [27685]: eth1: soliciting an IPv6 router
May 09 15:57:11 [27685]: eth1: sending Router Solicitation
May 09 15:57:11 [27685]: eth1: broadcasting REBIND6 (xid 0x1ae134), next in 1.0 seconds May 09 15:57:12 [27685]: eth1: broadcasting REBIND6 (xid 0x1ae134), next in 2.1 seconds May 09 15:57:14 [27685]: eth1: Router Advertisement from fe80::f899:b5ad:6686:f69e
May 09 15:57:14 [27685]: eth1: adding route to 2001:4201:0:50::/64
May 09 15:57:14 [27685]: eth1: executing `/etc/conf/bin/dhcpcd-up' ROUTERADVERT May 09 15:57:34 [27685]: eth1: broadcasting REBIND6 (xid 0x1ae134), next in 4.2 seconds May 09 15:57:34 [27685]: eth1: sending DISCOVER (xid 0x8266886d), next in 7.4 seconds
*May 09 15:57:34 [27685]: eth1: failed to rebind prior delegation*
May 09 15:57:34 [27685]: eth1: adding address 2001:4201:0:50::104/128
May 09 15:57:34 [27685]: eth1: pltime 601393 seconds, vltime 2588593 seconds
May 09 15:57:34 [27685]: eth1: renew in 1276, rebind in 4876, expire in 2588593 seconds
May 09 15:57:34 [27685]: lo: adding reject route to 2001:4201:0:51:3000::/68
May 09 15:57:34 [27685]: eth1: delegated prefix 2001:4201:0:51:3000::/68
May 09 15:57:34 [27685]: eth0: adding address 2001:4201:0:51:30d0::1/76
May 09 15:57:34 [27685]: eth0: pltime 601393 seconds, vltime 2588593 seconds
May 09 15:57:34 [27685]: eth0: waiting for DHCPv6 DAD to complete
May 09 15:57:34 [27685]: eth0: adding route to 2001:4201:0:51:30d0::/76
May 09 15:57:34 [27685]: eth1: waiting for DHCPv6 DAD to complete
*May 09 15:57:34 [27685]: eth1: DHCPv6 reply received but already bound*

Due to the above, I am not able to get the REBIND6 event in the hook script.
Could you please let me know what could be going wrong.

The full log from dhcpcd starting would be nice.
Specifically I am interested in any errors listening to sockets.
Also, are any other DHCP daemons running?

Roy

Follow-Ups:
Re: DHCPv6 RebindShweta Kalyani
References:
DHCPv6 RebindShweta Kalyani
Archive administrator: postmaster@marples.name