[Kea-users] No answer from kea

Thu Jul 20 11:42:42 UTC 2017

On 20.07.2017 12:54, itay cohen wrote:
>
> > Can someone tell me why kea is not answering to this request ?
> >
> >  
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.packets/13276]
> > DHCP4_PACKET_RECEIVED [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb: DHCPDISCOVER (type 1)
> > received from 172.20.220.81 to 172.20.221.155 on interface ens160
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.packets/13276]
> > DHCP4_QUERY_DATA [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb, packet details:
> > local_address=172.20.221.155:67, remote_address=172.20.220.81:67,
> > msg_type=DHCPDISCOVER (1), transid=0xbdb,
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.packets/13276]
> > DHCP4_SUBNET_SELECTED [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb: the subnet with ID 2 was
> > selected for client assignments
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.packets/13276]
> > DHCP4_SUBNET_DATA [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb: the selected subnet details:
> > 172.20.220.80/28
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_IDENTIFIER get one host with IPv4
> > reservation for subnet id 2, identified by hwaddr=00A012DA26D0
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_IDENTIFIER get all hosts with reservations using
> > identifier: hwaddr=00A012DA26D0
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_IDENTIFIER_COUNT using identifier
> > hwaddr=00A012DA26D0, found 0 host(s)
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_IDENTIFIER_NULL host not found using
> > subnet id 2 and identifier hwaddr=00A012DA26D0
> >
> > 2017-07-20 12:50:51.344 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_IDENTIFIER get one host with IPv4
> > reservation for subnet id 2, identified by hwaddr=00A012DA26D0
> >
> > 2017-07-20 12:50:51.345 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_IDENTIFIER_NULL host not found
> > using subnet id 2 and identifier hwaddr=00A012DA26D0
> >
> > 2017-07-20 12:50:51.345 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_IDENTIFIER get one host with IPv4
> > reservation for subnet id 2, identified by
> > circuit-id=3034303936343139395F4D4E473A766C616E393939
> >
> > 2017-07-20 12:50:51.345 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_IDENTIFIER get all hosts with reservations using
> > identifier: circuit-id=3034303936343139395F4D4E473A766C616E393939
> >
> > 2017-07-20 12:50:51.345 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_IDENTIFIER_COUNT using identifier
> > circuit-id=3034303936343139395F4D4E473A766C616E393939, found 0 host(s)
> >
> > 2017-07-20 12:50:51.345 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_IDENTIFIER_NULL host not found using
> > subnet id 2 and identifier
> > circuit-id=3034303936343139395F4D4E473A766C616E393939
> >
> > 2017-07-20 12:50:51.345 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_IDENTIFIER get one host with IPv4
> > reservation for subnet id 2, identified by
> > circuit-id=3034303936343139395F4D4E473A766C616E393939
> >
> > 2017-07-20 12:50:51.346 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_IDENTIFIER_NULL host not found
> > using subnet id 2 and identifier
> > circuit-id=3034303936343139395F4D4E473A766C616E393939
> >
> > 2017-07-20 12:50:51.346 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_IDENTIFIER get one host with IPv4
> > reservation for subnet id 2, identified by client-id=0100A012DA26D000
> >
> > 2017-07-20 12:50:51.346 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_IDENTIFIER get all hosts with reservations using
> > identifier: client-id=0100A012DA26D000
> >
> > 2017-07-20 12:50:51.346 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_IDENTIFIER_COUNT using identifier
> > client-id=0100A012DA26D000, found 0 host(s)
> >
> > 2017-07-20 12:50:51.346 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_IDENTIFIER_NULL host not found using
> > subnet id 2 and identifier client-id=0100A012DA26D000
> >
> > 2017-07-20 12:50:51.346 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_IDENTIFIER get one host with IPv4
> > reservation for subnet id 2, identified by client-id=0100A012DA26D000
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_IDENTIFIER_NULL host not found
> > using subnet id 2 and identifier client-id=0100A012DA26D000
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.ddns/13276]
> > DHCP4_CLIENT_HOSTNAME_PROCESS [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb: processing client's Hostname
> > option
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.dhcpsrv/13276]
> > DHCPSRV_MYSQL_GET_SUBID_CLIENTID obtaining IPv4 lease for subnet ID 2
> > and client ID 01:00:a0:12:da:26:d0:00
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.dhcpsrv/13276]
> > DHCPSRV_MYSQL_GET_HWADDR obtaining IPv4 leases for hardware address
> > hwtype=1 00:a0:12:da:26:d0
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.alloc-engine/13276]
> > ALLOC_ENGINE_V4_OFFER_NEW_LEASE allocation engine will try to offer
> > new lease to the client [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for
> > subnet id 2 and IPv4 address 172.20.220.82
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4
> > address 172.20.220.82
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 172.20.220.82, found 0
> > host(s)
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet
> > id 2 and address 172.20.220.82
> >
> > 2017-07-20 12:50:51.347 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_ADDRESS4 trying alternate source
> > for host using subnet id 2 and address 172.20.220.82
> >
> > 2017-07-20 12:50:51.348 DEBUG [kea-dhcp4.dhcpsrv/13276]
> > DHCPSRV_MYSQL_GET_ADDR4 obtaining IPv4 lease for address 172.20.220.82
> >
> > 2017-07-20 12:50:51.348 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for
> > subnet id 2 and IPv4 address 172.20.220.83
> >
> > 2017-07-20 12:50:51.348 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4
> > address 172.20.220.83
> >
> > 2017-07-20 12:50:51.348 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 172.20.220.83, found 0
> > host(s)
> >
> > 2017-07-20 12:50:51.348 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet
> > id 2 and address 172.20.220.83
> >
> > 2017-07-20 12:50:51.348 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_ADDRESS4 trying alternate source
> > for host using subnet id 2 and address 172.20.220.83
> >
> > 2017-07-20 12:50:51.349 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for
> > subnet id 2 and IPv4 address 172.20.220.84
> >
> > 2017-07-20 12:50:51.349 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4
> > address 172.20.220.84
> >
> > 2017-07-20 12:50:51.349 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 172.20.220.84, found 0
> > host(s)
> >
> > 2017-07-20 12:50:51.349 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet
> > id 2 and address 172.20.220.84
> >
> > 2017-07-20 12:50:51.349 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_ADDRESS4 trying alternate source
> > for host using subnet id 2 and address 172.20.220.84
> >
> > 2017-07-20 12:50:51.350 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for
> > subnet id 2 and IPv4 address 172.20.220.85
> >
> > 2017-07-20 12:50:51.350 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4
> > address 172.20.220.85
> >
> > 2017-07-20 12:50:51.350 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 172.20.220.85, found 0
> > host(s)
> >
> > 2017-07-20 12:50:51.350 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet
> > id 2 and address 172.20.220.85
> >
> > 2017-07-20 12:50:51.350 DEBUG [kea-dhcp4.hosts/13276]
> > HOSTS_MGR_ALTERNATE_GET4_SUBNET_ID_ADDRESS4 trying alternate source
> > for host using subnet id 2 and address 172.20.220.85
> >
> > 2017-07-20 12:50:51.350 DEBUG [kea-dhcp4.dhcpsrv/13276]
> > DHCPSRV_MYSQL_GET_ADDR4 obtaining IPv4 lease for address 172.20.220.85
> >
> > 2017-07-20 12:50:51.350 WARN  [kea-dhcp4.alloc-engine/13276]
> > ALLOC_ENGINE_V4_ALLOC_FAIL [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb: failed to allocate an IPv4
> > address after 4 attempt(s)
> >
> > 2017-07-20 12:50:51.350 DEBUG [kea-dhcp4.bad-packets/13276]
> > DHCP4_PACKET_NAK_0003 [hwtype=1 00:a0:12:da:26:d0],
> > cid=[01:00:a0:12:da:26:d0:00], tid=0xbdb: failed to advertise a lease,
> > client sent ciaddr 0.0.0.0, requested-ip-address (no address)
> >

It looks like you have a short pool of addresses in your address pools
(four) and you have ran out of them, i.e. they have been allocated to
some other clients.

Marcin Siodelski
ISC