Send dhcp-users mailing list submissions to dhcp-users@lists.isc.org
To subscribe or unsubscribe via the World Wide Web, visit https://lists.isc.org/mailman/listinfo/dhcp-users or, via email, send a message with subject or body 'help' to dhcp-users-requ...@lists.isc.org You can reach the person managing the list at dhcp-users-ow...@lists.isc.org When replying, please edit your Subject line so it is more specific than "Re: Contents of dhcp-users digest..." Today's Topics: 1. "peer holds all free leases" (Marc Haber) ---------------------------------------------------------------------- Message: 1 Date: Wed, 16 Sep 2020 08:05:13 +0200 From: Marc Haber <mh+dhcp-us...@zugschlus.de> To: Users of ISC DHCP <dhcp-users@lists.isc.org> Subject: "peer holds all free leases" Message-ID: <20200916060513.ga5...@torres.zugschlus.de> Content-Type: text/plain; charset=utf-8 Hi, I am running a redundant DHCP setup on Debian stable, ISC DHCP version 4.4.1, with a handful of pools for a handful of different VLANs. Yesterday afternoon, no configuration change, both servers simultaneously began logging Sep 16 07:22:46 chasse dhcpd[9806]: DHCPDISCOVER from b4:e6:2d:5b:99:19 via 192.168.184.254: peer holds all free leases for one pool. I do not understand this error message. (1) Replication is fine: Sep 16 07:02:24 chasse dhcpd[9806]: balancing pool 5617e1957e80 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-own (+/-)12 Sep 16 07:02:24 chasse dhcpd[9806]: balanced pool 5617e1957e80 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-misbal 18 Sep 16 07:02:24 cadencia dhcpd[10213]: balancing pool 1269af8 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-own (+/-)12 Sep 16 07:02:24 cadencia dhcpd[10213]: balanced pool 1269af8 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-misbal 18 I also see both machines talking to each other on TCP port 647, restarting either server tears down the TCP session an rebuilds it again (2) The pool has ample free addresses I even increased the pool size by 20 addresses. This didn't change the issue, no IP addresses are handed out to clients. (3) classes are not in use. There are on "class" statements in configuration Why do my servers suddenly think that clients are not eligible for a lase from this pool? I have moved one of the affected clients to a different VLAN and it immediately got a lease assigned. Greetings Marc Here is the relevant configuration. pool 184 is the one that doesn't work, pool 189 is the one that works. chasse: failover peer "chasse-cadencia" { primary; address chasse.ka51.example.com; peer address unt381.cadencia.ka51.example.com; max-response-delay 60; max-unacked-updates 10; mclt 3600; # 300 if redundancy is in place split 192; load balance max seconds 3; } cadencia: failover peer "chasse-cadencia" { secondary; address unt381.cadencia.ka51.example.com; peer address chasse.ka51.example.com; max-response-delay 60; max-unacked-updates 10; load balance max seconds 3; } identical on both (included and rsynced): option domain-name "ka51.example.com"; option domain-search "ka51.example.com", "example.com"; option domain-name-servers dnsrec1.ka51.example.com, dnsrec2.ka51.example.com; option ntp-servers ntp1.ka51.example.com, ntp2.ka51.example.com; default-lease-time 14400; # 12 hours max-lease-time 14400; # 12 hours not authoritative; log-facility local7; deny bootp; adaptive-lease-time-threshold 80; ddns-update-style standard; ddns-rev-domainname "in-addr.arpa."; zone ka51.example.com. { primary lasso.ka51.example.com; key lasso-chasse-dhcp; } subnet 192.168.184.0 netmask 255.255.255.0 { # int184 pool { range 192.168.184.130 192.168.184.249; failover peer "chasse-cadencia"; deny known-clients; } option routers v4gw.int184.ka51.example.com; ddns-domainname "ka51.example.com"; authoritative; } zone 184.168.192.in-addr.arpa. { primary lasso.ka51.example.com; key lasso-chasse-dhcp; } subnet 192.168.189.0 netmask 255.255.255.0 { # int189 pool { range 192.168.189.150 192.168.189.249; failover peer "chasse-cadencia"; deny known-clients; } option routers v4gw.int189.ka51.example.com; ddns-domainname "ka51.example.com"; authoritative; } zone 189.168.192.in-addr.arpa. { primary lasso.ka51.example.com; key lasso-chasse-dhcp; } Here is what the servers log on startup: Sep 16 07:58:42 chasse systemd[1]: Stopping ISC DHCP Server for IPv4 (dhcpd.conf)... Sep 16 07:58:42 chasse systemd[1]: isc-dhcp-server-v4.service: Main process exited, code=killed, status=15/TERM Sep 16 07:58:42 chasse systemd[1]: isc-dhcp-server-v4.service: Succeeded. Sep 16 07:58:42 chasse systemd[1]: Stopped ISC DHCP Server for IPv4 (dhcpd.conf). Sep 16 07:58:48 chasse systemd[1]: Starting ISC DHCP Server for IPv4 (dhcpd.conf)... Sep 16 07:58:48 chasse dhcpd[19535]: Internet Systems Consortium DHCP Server 4.4.1 Sep 16 07:58:48 chasse dhcpd[19535]: Copyright 2004-2018 Internet Systems Consortium. Sep 16 07:58:48 chasse dhcpd[19535]: All rights reserved. Sep 16 07:58:48 chasse dhcpd[19535]: For info, please visit https://www.isc.org/software/dhcp/ Sep 16 07:58:48 chasse systemd[1]: Started ISC DHCP Server for IPv4 (dhcpd.conf). Sep 16 07:58:48 chasse dhcpd[19536]: Internet Systems Consortium DHCP Server 4.4.1 Sep 16 07:58:49 chasse dhcpd[19536]: Copyright 2004-2018 Internet Systems Consortium. Sep 16 07:58:49 chasse dhcpd[19536]: All rights reserved. Sep 16 07:58:49 chasse dhcpd[19536]: For info, please visit https://www.isc.org/software/dhcp/ Sep 16 07:58:49 chasse dhcpd[19536]: Wrote 0 deleted host decls to leases file. Sep 16 07:58:49 chasse dhcpd[19536]: Wrote 0 new dynamic host decls to leases file. Sep 16 07:58:49 chasse dhcpd[19536]: Wrote 1012 leases to leases file. Sep 16 07:58:49 chasse dhcpd[19536]: failover peer chasse-cadencia: I move from normal to startup Sep 16 07:58:49 chasse dhcpd[19536]: Server starting service. Sep 16 07:58:49 chasse dhcpd[19536]: failover peer chasse-cadencia: peer moves from normal to communications-interrupted Sep 16 07:58:49 chasse dhcpd[19536]: failover peer chasse-cadencia: I move from startup to normal Sep 16 07:58:49 chasse dhcpd[19536]: balancing pool 5650a31a3ac0 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-own (+/-)10 Sep 16 07:58:49 chasse dhcpd[19536]: balanced pool 5650a31a3ac0 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-misbal 15 Sep 16 07:58:49 chasse dhcpd[19536]: balancing pool 5650a316be80 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-own (+/-)12 Sep 16 07:58:49 chasse dhcpd[19536]: balanced pool 5650a316be80 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-misbal 18 Sep 16 07:58:49 chasse dhcpd[19536]: failover peer chasse-cadencia: peer moves from communications-interrupted to normal Sep 16 07:58:49 chasse dhcpd[19536]: failover peer chasse-cadencia: Both servers normal Sep 16 07:58:42 cadencia dhcpd[10213]: peer chasse-cadencia: disconnected Sep 16 07:58:42 cadencia dhcpd[10213]: failover peer chasse-cadencia: I move from normal to communications-interrupted Sep 16 07:58:47 cadencia ippl: ICMP message type redirect - for host from 192.168.251.254 Sep 16 07:58:49 cadencia dhcpd[10213]: failover peer chasse-cadencia: peer moves from normal to normal Sep 16 07:58:49 cadencia dhcpd[10213]: failover peer chasse-cadencia: I move from communications-interrupted to normal Sep 16 07:58:49 cadencia dhcpd[10213]: failover peer chasse-cadencia: Both servers normal Sep 16 07:58:49 cadencia dhcpd[10213]: balancing pool 128ae38 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-own (+/-)10 Sep 16 07:58:49 cadencia dhcpd[10213]: balanced pool 128ae38 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-misbal 15 Sep 16 07:58:49 cadencia dhcpd[10213]: balancing pool 1269af8 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-own (+/-)12 Sep 16 07:58:49 cadencia dhcpd[10213]: balanced pool 1269af8 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-misbal 18 Sep 16 08:00:57 cadencia systemd[1]: Stopping ISC DHCP Server for IPv4 (dhcpd.conf)... Sep 16 08:00:57 cadencia systemd[1]: isc-dhcp-server-v4.service: Main process exited, code=killed, status=15/TERM Sep 16 08:00:57 cadencia systemd[1]: isc-dhcp-server-v4.service: Succeeded. Sep 16 08:00:57 cadencia systemd[1]: Stopped ISC DHCP Server for IPv4 (dhcpd.conf). Sep 16 08:01:10 cadencia ippl: ICMP message type redirect - for host from 192.168.251.254 Sep 16 08:01:14 cadencia systemd[1]: Starting ISC DHCP Server for IPv4 (dhcpd.conf)... Sep 16 08:01:14 cadencia dhcpd[5819]: Internet Systems Consortium DHCP Server 4.4.1 Sep 16 08:01:14 cadencia dhcpd[5819]: Copyright 2004-2018 Internet Systems Consortium. Sep 16 08:01:14 cadencia dhcpd[5819]: All rights reserved. Sep 16 08:01:14 cadencia dhcpd[5819]: For info, please visit https://www.isc.org/software/dhcp/ Sep 16 08:01:14 cadencia systemd[1]: Started ISC DHCP Server for IPv4 (dhcpd.conf). Sep 16 08:01:14 cadencia dhcpd[5820]: Internet Systems Consortium DHCP Server 4.4.1 Sep 16 08:01:14 cadencia dhcpd[5820]: Copyright 2004-2018 Internet Systems Consortium. Sep 16 08:01:14 cadencia dhcpd[5820]: All rights reserved. Sep 16 08:01:14 cadencia dhcpd[5820]: For info, please visit https://www.isc.org/software/dhcp/ Sep 16 08:01:14 cadencia dhcpd[5820]: Wrote 0 deleted host decls to leases file. Sep 16 08:01:14 cadencia dhcpd[5820]: Wrote 0 new dynamic host decls to leases file. Sep 16 08:01:14 cadencia dhcpd[5820]: Wrote 1012 leases to leases file. Sep 16 08:01:14 cadencia dhcpd[5820]: failover peer chasse-cadencia: I move from normal to startup Sep 16 08:01:14 cadencia dhcpd[5820]: Server starting service. Sep 16 08:01:14 cadencia dhcpd[5820]: failover peer chasse-cadencia: peer moves from normal to communications-interrupted Sep 16 08:01:14 cadencia dhcpd[5820]: failover peer chasse-cadencia: I move from startup to normal Sep 16 08:01:14 cadencia dhcpd[5820]: balancing pool 121fe38 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-own (+/-)10 Sep 16 08:01:14 cadencia dhcpd[5820]: balanced pool 121fe38 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-misbal 15 Sep 16 08:01:14 cadencia dhcpd[5820]: balancing pool 11feaf8 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-own (+/-)12 Sep 16 08:01:14 cadencia dhcpd[5820]: balanced pool 11feaf8 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-misbal 18 Sep 16 08:01:15 cadencia dhcpd[5820]: failover peer chasse-cadencia: peer moves from communications-interrupted to normal Sep 16 08:01:15 cadencia dhcpd[5820]: failover peer chasse-cadencia: Both servers normal Sep 16 08:00:57 chasse dhcpd[19536]: peer chasse-cadencia: disconnected Sep 16 08:00:57 chasse dhcpd[19536]: failover peer chasse-cadencia: I move from normal to communications-interrupted Sep 16 08:01:01 chasse dhcpd[814]: Relay-forward message from 2a01:238:42bc:a181::70:100 port 547, link address 2a01:238:42bc:a18c::70:100, peer ad Sep 16 08:01:01 chasse dhcpd[814]: No subnet found for link-address 2a01:238:42bc:a18c::70:100. Sep 16 08:01:02 chasse dhcpd[19536]: DHCPDISCOVER from 2c:f4:32:db:c3:06 via 192.168.184.254: peer holds all free leases Sep 16 08:01:04 chasse dhcpd[19536]: DHCPDISCOVER from 2c:f4:32:db:c3:06 via 192.168.184.254: peer holds all free leases Sep 16 08:01:08 chasse dhcpd[19536]: DHCPDISCOVER from 2c:f4:32:db:c3:06 via 192.168.184.254: peer holds all free leases Sep 16 08:01:13 chasse dhcpd[19536]: DHCPDISCOVER from 2c:f4:32:db:c3:06 via 192.168.184.254: peer holds all free leases Sep 16 08:01:14 chasse dhcpd[814]: Solicit message from fe80::5054:ff:fe9e:9a15 port 546, transaction ID 0x1D67E000 Sep 16 08:01:14 chasse dhcpd[814]: Lease for b55e:67ff:0:0:0:0 leased to d6:16:75:5:f2:ba Sep 16 08:01:14 chasse dhcpd[814]: Unable to pick client address: no IPv6 pools on this shared network Sep 16 08:01:14 chasse dhcpd[814]: Sending Reply to fe80::5054:ff:fe9e:9a15 port 546 Sep 16 08:01:14 chasse dhcpd[814]: Relay-forward message from 2a01:238:42bc:a181::70:100 port 547, link address 2a01:238:42bc:a181::70:100, peer ad Sep 16 08:01:14 chasse dhcpd[814]: Lease for b55e:67ff:0:0:0:0 leased to d6:16:75:5:f2:ba Sep 16 08:01:14 chasse dhcpd[814]: Unable to pick client address: no IPv6 pools on this shared network Sep 16 08:01:14 chasse dhcpd[814]: Sending Relay-reply to 2a01:238:42bc:a181::70:100 port 547 Sep 16 08:01:14 chasse dhcpd[19536]: failover peer chasse-cadencia: peer moves from normal to normal Sep 16 08:01:14 chasse dhcpd[19536]: failover peer chasse-cadencia: I move from communications-interrupted to normal Sep 16 08:01:14 chasse dhcpd[19536]: failover peer chasse-cadencia: Both servers normal Sep 16 08:01:14 chasse dhcpd[19536]: balancing pool 5650a31a3ac0 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-own (+/-)10 Sep 16 08:01:14 chasse dhcpd[19536]: balanced pool 5650a31a3ac0 192.168.189.0/24 total 100 free 49 backup 49 lts 0 max-misbal 15 Sep 16 08:01:14 chasse dhcpd[19536]: balancing pool 5650a316be80 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-own (+/-)12 Sep 16 08:01:14 chasse dhcpd[19536]: balanced pool 5650a316be80 192.168.184.0/24 total 120 free 58 backup 59 lts 0 max-misbal 18 -- ----------------------------------------------------------------------------- Marc Haber | "I don't trust Computers. They | Mailadresse im Header Leimen, Germany | lose things." Winona Ryder | Fon: *49 6224 1600402 Nordisch by Nature | How to make an American Quilt | Fax: *49 6224 1600421 ------------------------------ Subject: Digest Footer _______________________________________________ ISC funds the development of this software with paid support subscriptions. Contact us at https://www.isc.org/contact/ for more information. dhcp-users mailing list dhcp-users@lists.isc.org https://lists.isc.org/mailman/listinfo/dhcp-users ------------------------------ End of dhcp-users Digest, Vol 143, Issue 4 ******************************************