[Kea-users] Unable to get offers from kea- DHCP appliance

Fri Jul 21 22:03:58 UTC 2023

Hi Kraishak,

Post your configuration for that subnet.

Thank you,

Darren Ankney

On Fri, Jul 21, 2023 at 8:59 AM Kraishak Mahtha <kraishak.edu at gmail.com> wrote:
>
> Hi Darren,
> That is where I get doubts I see only one lease from that 4.0.0.0 subnet when I execute this command
> /usr/bin/echo '{"command":"lease4-get-all"}' | /usr/bin/socat - UNIX:/tmp/kea4-ctrl-socket and that is also the day before yesterday's one where it worked fine.
> And we have around 150+ Ip's still available from that subnet
>
> Thanks Kraishak
>
>
>
>
> On Thu, Jul 20, 2023 at 11:47 PM Darren Ankney <darren.ankney at gmail.com> wrote:
>>
>> Hi Kraishak,
>>
>> I found an example transaction (0x67937012) showing a failure (logs
>> below).  It looks like it couldn't find a free address in the subnet.
>> Is your subnet full?
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.packets/7850.140433344689920]
>> DHCP4_PACKET_RECEIVED [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: DHCPDISCOVER (type 1)
>> received from 4.0.0.1 to 192.168.0.125 on interface eth0
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.packets/7850.140433344689920]
>> DHCP4_QUERY_DATA [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012, packet details:
>> local_address=192.168.0.125:67, remote_address=4.0.0.1:67,
>> msg_type=DHCPDISCOVER (1), transid=0x67937012,
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.packets/7850.140433344689920]
>> DHCP4_SUBNET_SELECTED [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: the subnet with ID 786966
>> was selected for client assignments
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.packets/7850.140433344689920]
>> DHCP4_SUBNET_DATA [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: the selected subnet
>> details: 4.0.0.0/16
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.dhcp4/7850.140433344689920]
>> DHCP4_CLASS_ASSIGNED [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: client packet has been
>> assigned to the following class(es): UNKNOWN
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.dhcp4/7850.140433344689920]
>> DHCP4_CLASS_ASSIGNED [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: client packet has been
>> assigned to the following class(es): ALL, allow-client, UNKNOWN
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.ddns/7850.140433344689920]
>> DHCP4_CLIENT_HOSTNAME_PROCESS [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: processing client's
>> Hostname option
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.ddns/7850.140433344689920]
>> DHCP4_CLIENT_HOSTNAME_DATA [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: client sent Hostname
>> option: dhcp-client-000005
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.ddns/7850.140433344689920]
>> DHCP4_CLIENT_HOSTNAME_DATA [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: client sent Hostname
>> option: dhcp-client-000005
>>
>> 2023-07-20 12:53:20.793 DEBUG [kea-dhcp4.ddns/7850.140433344689920]
>> DHCP4_RESPONSE_HOSTNAME_DATA [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: including Hostname option
>> in the server's response: dhcp-client-000005
>>
>> 2023-07-20 12:53:20.793 DEBUG
>> [kea-dhcp4.alloc-engine/7850.140433344689920]
>> ALLOC_ENGINE_V4_OFFER_NEW_LEASE allocation engine will try to offer
>> new lease to the client [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012
>>
>> 2023-07-20 12:53:20.850 WARN
>> [kea-dhcp4.alloc-engine/7850.140433344689920]
>> ALLOC_ENGINE_V4_ALLOC_FAIL_SUBNET [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: failed to allocate an IPv4
>> lease in the subnet 4.0.0.0/16, subnet-id 786966, shared network
>> (none)
>>
>> 2023-07-20 12:53:20.850 WARN
>> [kea-dhcp4.alloc-engine/7850.140433344689920]
>> ALLOC_ENGINE_V4_ALLOC_FAIL [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: failed to allocate an IPv4
>> address after 244 attempt(s)
>>
>> 2023-07-20 12:53:20.850 WARN
>> [kea-dhcp4.alloc-engine/7850.140433344689920]
>> ALLOC_ENGINE_V4_ALLOC_FAIL_CLASSES [hwtype=1 11:3f:ff:00:00:05],
>> cid=[01:11:3f:ff:00:00:05], tid=0x67937012: Failed to allocate an IPv4
>> address for client with classes: ALL, allow-client, UNKNOWN
>>
>> 2023-07-20 12:53:20.850 DEBUG
>> [kea-dhcp4.bad-packets/7850.140433344689920] DHCP4_PACKET_NAK_0003
>> [hwtype=1 11:3f:ff:00:00:05], cid=[01:11:3f:ff:00:00:05],
>> tid=0x67937012: failed to advertise a lease, client sent ciaddr
>> 0.0.0.0, requested-ip-address (no address)
>>
>> Thank you,
>>
>> Darren Ankney
>>
>> On Thu, Jul 20, 2023 at 11:31 AM Kraishak Mahtha <kraishak.edu at gmail.com> wrote:
>> >
>> > Hi All,
>> >
>> > I have two subnets 3.4.0.0/16 and 4.0.0.0/16 configured on the kea DHCP standalone appliance, It used to work fine able to get leases from both subnets but today, I am not able to get the leases from 4.0.0.0 subnet (3.4.0.0 is working fine and both have same options and that too basic router and lease time...)
>> > I see the discover packet is being sent to the DHCP appliance but it is not sending any offer, I tried checking the logs I see the server is being tried for different IPs like :
>> >
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for subnet id 786966 and IPv4 address 4.0.0.2
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4 address 4.0.0.2
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 4.0.0.2, found 0 host(s)
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet id 786966 and address 4.0.0.2
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.dhcpsrv/7850.140433336297216] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 4.0.0.2
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for subnet id 786966 and IPv4 address 4.0.0.3
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4 address 4.0.0.3
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 4.0.0.3, found 0 host(s)
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet id 786966 and address 4.0.0.3
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.dhcpsrv/7850.140433336297216] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 4.0.0.3
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for subnet id 786966 and IPv4 address 4.0.0.4
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4 address 4.0.0.4
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 4.0.0.4, found 0 host(s)
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet id 786966 and address 4.0.0.4
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.dhcpsrv/7850.140433336297216] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 4.0.0.4
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4 get one host with reservation for subnet id 786966 and IPv4 address 4.0.0.5
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4 get all hosts with reservations for IPv4 address 4.0.0.5
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ALL_ADDRESS4_COUNT using address 4.0.0.5, found 0 host(s)
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.hosts/7850.140433336297216] HOSTS_CFG_GET_ONE_SUBNET_ID_ADDRESS4_NULL host not found using subnet id 786966 and address 4.0.0.5
>> > 2023-07-20 12:53:20.766 DEBUG [kea-dhcp4.dhcpsrv/7850.140433336297216] DHCPSRV_MEMFILE_GET_ADDR4 obtaining IPv4 lease for address 4.0.0.5
>> >
>> >
>> > I thought it would be because that IP is being used but in the network, I don't see anyone having IP with that and also kea won't do ping before offering to my knowledge.
>> >
>> > Please find the attached log files for more info on kea-dhcp4 and kea-dhcp4.packets module.
>> >
>> > Overview summary
>> > Subnet 4.0.0.0 has a MAC address with a pattern: 11:3f:ff****
>> > Subnet 3.4.0.0 has a MAC address with a pattern: 14:3f:ff:***
>> >
>> > Can some mean please guide why the server is unable to offer leases for the 4.0.0.0 subnet
>> >
>> > Thanks in Advance
>> > Kraishak
>> > --
>> > ISC funds the development of this software with paid support subscriptions. Contact us at https://www.isc.org/contact/ for more information.
>> >
>> > To unsubscribe visit https://lists.isc.org/mailman/listinfo/kea-users.
>> >
>> > Kea-users mailing list
>> > Kea-users at lists.isc.org
>> > https://lists.isc.org/mailman/listinfo/kea-users
>> --
>> ISC funds the development of this software with paid support subscriptions. Contact us at https://www.isc.org/contact/ for more information.
>>
>> To unsubscribe visit https://lists.isc.org/mailman/listinfo/kea-users.
>>
>> Kea-users mailing list
>> Kea-users at lists.isc.org
>> https://lists.isc.org/mailman/listinfo/kea-users