[Kea-users] error message

BÖSCH Christian boesch at fhv.at
Mon Nov 11 08:22:46 UTC 2024 

Hi Darren, 

Thanks for your response. 
When I search for one of those trasaction id I see the following every few minutes: 
2024-11-11T09:02:27.426337+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287691511488] DHCP4_QUERY_LABEL received query: [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5 
2024-11-11T09:02:27.426544+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_RECEIVED [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: DHCPREQUEST (type 3) received from 172.21.11.104 to 10.0.30.111 on interface ens192 
2024-11-11T09:02:27.426619+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.leases.140287691511488] DHCP4_LEASE_ALLOC [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: lease 172.21.11.104 has been allocated for 14400 seconds 
2024-11-11T09:02:27.427083+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287691511488] EVAL_RESULT [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: Expression fhv-registered evaluated to true 
2024-11-11T09:02:27.438849+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_SEND [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: trying to send packet DHCPACK (type 5) from 10.0.30.111:67 to 255.255.255.255:68 on interface ens192 
2024-11-11T09:02:27.438961+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_SEND_FAIL [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied 
2024-11-11T09:03:32.283802+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] DHCP4_QUERY_LABEL received query: [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5 
2024-11-11T09:03:32.284024+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_RECEIVED [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: DHCPREQUEST (type 3) received from 172.21.11.104 to 10.0.30.111 on interface ens192 
2024-11-11T09:03:32.284107+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.leases.140287699904192] DHCP4_LEASE_ALLOC [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: lease 172.21.11.104 has been allocated for 14400 seconds 
2024-11-11T09:03:32.284166+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] EVAL_RESULT [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: Expression fhv-registered evaluated to true 
2024-11-11T09:03:32.284715+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: trying to send packet DHCPACK (type 5) from 10.0.30.111:67 to 255.255.255.255:68 on interface ens192 
2024-11-11T09:03:32.284808+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND_FAIL [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied 
2024-11-11T09:04:36.857375+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] DHCP4_QUERY_LABEL received query: [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5 
2024-11-11T09:04:36.857454+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_RECEIVED [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: DHCPREQUEST (type 3) received from 172.21.11.104 to 10.0.30.111 on interface ens192 
2024-11-11T09:04:36.857487+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.leases.140287699904192] DHCP4_LEASE_ALLOC [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: lease 172.21.11.104 has been allocated for 14400 seconds 
2024-11-11T09:04:36.857537+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] EVAL_RESULT [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: Expression fhv-registered evaluated to true 
2024-11-11T09:04:36.858498+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: trying to send packet DHCPACK (type 5) from 10.0.30.111:67 to 255.255.255.255:68 on interface ens192 
2024-11-11T09:04:36.858559+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND_FAIL [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied 
2024-11-11T09:05:40.520854+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287691511488] DHCP4_QUERY_LABEL received query: [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5 
2024-11-11T09:05:40.521036+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_RECEIVED [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: DHCPREQUEST (type 3) received from 172.21.11.104 to 10.0.30.111 on interface ens192 
2024-11-11T09:05:40.521103+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.leases.140287691511488] DHCP4_LEASE_ALLOC [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: lease 172.21.11.104 has been allocated for 14400 seconds 
2024-11-11T09:05:40.521160+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287691511488] EVAL_RESULT [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: Expression fhv-registered evaluated to true 
2024-11-11T09:05:40.521654+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_SEND [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: trying to send packet DHCPACK (type 5) from 10.0.30.111:67 to 255.255.255.255:68 on interface ens192 
2024-11-11T09:05:40.521719+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_SEND_FAIL [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied 
2024-11-11T09:06:44.958621+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] DHCP4_QUERY_LABEL received query: [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5 
2024-11-11T09:06:44.958856+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_RECEIVED [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: DHCPREQUEST (type 3) received from 172.21.11.104 to 10.0.30.111 on interface ens192 
2024-11-11T09:06:44.958942+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.leases.140287699904192] DHCP4_LEASE_ALLOC [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: lease 172.21.11.104 has been allocated for 14400 seconds 
2024-11-11T09:06:44.959020+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] EVAL_RESULT [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: Expression fhv-registered evaluated to true 
2024-11-11T09:06:44.959921+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: trying to send packet DHCPACK (type 5) from 10.0.30.111:67 to 255.255.255.255:68 on interface ens192 
2024-11-11T09:06:44.959993+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND_FAIL [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied 
2024-11-11T09:07:49.516452+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] DHCP4_QUERY_LABEL received query: [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5 
2024-11-11T09:07:49.516641+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_RECEIVED [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: DHCPREQUEST (type 3) received from 172.21.11.104 to 10.0.30.111 on interface ens192 
2024-11-11T09:07:49.516774+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.leases.140287699904192] DHCP4_LEASE_ALLOC [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: lease 172.21.11.104 has been allocated for 14400 seconds 
2024-11-11T09:07:49.517070+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287699904192] EVAL_RESULT [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: Expression fhv-registered evaluated to true 
2024-11-11T09:07:49.517204+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: trying to send packet DHCPACK (type 5) from 10.0.30.111:67 to 255.255.255.255:68 on interface ens192 
2024-11-11T09:07:49.517253+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_SEND_FAIL [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied 
2024-11-11T09:08:53.319427+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287691511488] DHCP4_QUERY_LABEL received query: [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5 
2024-11-11T09:08:53.319543+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287691511488] DHCP4_PACKET_RECEIVED [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: DHCPREQUEST (type 3) received from 172.21.11.104 to 10.0.30.111 on interface ens192 
2024-11-11T09:08:53.319586+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.leases.140287691511488] DHCP4_LEASE_ALLOC [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: lease 172.21.11.104 has been allocated for 14400 seconds 
2024-11-11T09:08:53.319636+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.dhcp4.140287691511488] EVAL_RESULT [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: Expression fhv-registered evaluated to true 
2024-11-11T09:08:53.322271+01:00 kea1 kea-dhcp4: INFO [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_SEND [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: trying to send packet DHCPACK (type 5) from 10.0.30.111:67 to 255.255.255.255:68 on interface ens192 
2024-11-11T09:08:53.322346+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140287699904192] DHCP4_PACKET_SEND_FAIL [hwtype=1 b8:27:eb:12:96:74], cid=[01:b8:27:eb:12:96:74], tid=0x64e8d7d5: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied 

Here is the config: 
{ 

"Dhcp4": { 
"interfaces-config": { 
"interfaces": [ "ens192" ], 
"dhcp-socket-type": "udp" 
}, 
"control-socket": { 
"socket-type": "unix", 
"socket-name": "/tmp/kea4-ctrl-socket" 
}, 
"lease-database": { 
"type": "memfile", 
"lfc-interval": 3600 
}, 
"expired-leases-processing": { 
"reclaim-timer-wait-time": 10, 
"flush-reclaimed-timer-wait-time": 25, 
"hold-reclaimed-time": 3600, 
"max-reclaim-leases": 100, 
"max-reclaim-time": 250, 
"unwarned-reclaim-cycles": 5 
}, 
"valid-lifetime": 3600, 
"authoritative": true, 
"dhcp-ddns" : { 
"enable-updates" : true, 
"server-ip": "127.0.0.1", 
"server-port":53001 
}, 

"option-data": [ 
{ 
"name": "domain-name-servers", 
"data": "10.0.30.31, 10.0.30.32" 
}, 
{ 
"name": "netbios-name-servers", 
"data": "10.0.20.52, 10.0.20.51" 
} 
], 

"reservations": [ 
<?include "reservations4.conf.include"?> 
], 

"client-classes": [ 
{ 
"name": "fhv-registered", 
"test": "member('KNOWN')", 
"only-if-required": true 
}, 
{ 
"name": "reservation" 
}, 
{ 
"name": "registered-server1", 
"test": "member('reservation') and member('HA_kea1')" 
}, 
{ 
"name": "registered-server2", 
"test": "member('reservation') and member('HA_kea2')" 
} 
], 

"hooks-libraries": [ 
{ 
"library": "/usr/lib/x86_64-linux-gnu/kea/hooks/libdhcp_lease_cmds.so", 
"parameters": { } 
}, 
{ 
"library": "/usr/lib/x86_64-linux-gnu/kea/hooks/libdhcp_ddns_tuning.so", 
"parameters": { } 
}, 
{ 
"library": "/usr/lib/x86_64-linux-gnu/kea/hooks/libdhcp_ha.so", 
"parameters": { 
"high-availability": [{ 
"this-server-name": "kea1", 
"mode": "load-balancing", 
"heartbeat-delay": 10000, 
"max-response-delay": 10000, 
"max-ack-delay": 5000, 
"max-unacked-clients": 5, 
"delayed-updates-limit": 100, 
"peers": [{ 
"name": "kea1", 
"url": "https://10.0.30.111:8000/", 
"role": "primary", 
"trust-anchor": "/etc/kea/certs/ca.crt", 
"cert-file": "/etc/kea/certs/kea-client.crt", 
"key-file": "/etc/kea/certs/kea-client.key", 
"auto-failover": true 
}, { 
"name": "kea2", 
"url": "https://10.0.30.112:8000/", 
"role": "secondary", 
"trust-anchor": "/etc/kea/certs/ca.crt", 
"cert-file": "/etc/kea/certs/kea-client.crt", 
"key-file": "/etc/kea/certs/kea-client.key", 
"auto-failover": true 
}] 
}] 
} 
} 
], 

"subnet4": [ 
{ 
"id": 21111, 
"subnet": "172.20.11.0/24", 
"valid-lifetime": 14400, 
"reservations-global": true, 
"require-client-classes": [ "fhv-registered" ], 
"match-client-id": false, 
"option-data": [ 
{ 
"name": "routers", 
"data": "172.20.11.1" 
}, 
{ 
"name": "ntp-servers", 
"data": "193.170.2.11, 193.170.2.12" 
}, 
{ 
"name": "domain-name", 
"data": "periph.abc.net" 
} 
] 
}, 
{ 
"id": 11111, 
"subnet": "172.21.11.0/24", 
"valid-lifetime": 14400, 
"reservations-global": true, 
"require-client-classes": [ "fhv-registered" ], 
"match-client-id": false, 
"option-data": [ 
{ 
"name": "routers", 
"data": "172.21.11.1" 
}, 
{ 
"name": "ntp-servers", 
"data": "193.170.2.11, 193.170.2.12" 
}, 
{ 
"name": "domain-name", 
"data": "periph.abc.net" 
} 
] 
}, 
], 

"loggers": [ 
{ 
"name": "kea-dhcp4", 
"output-options": [ 
{ 
"output": "syslog:local4" 
} 
], 
"severity": "INFO", 
"debuglevel": 0 
} 
] 
} 
} 

reservations4.conf.include: 
{ 
"hw-address": "b8:27:eb:12:96:74", 
"ip-address": "172.21.11.104" 
}, 
…. 

Thanks in advance, Christian 

On 08.11.24, 22:49, "Kea-users" <kea-users-bounces at lists.isc.org> wrote: 


Hi Christian,

I wonder if there is some interface difference or something? You
should be able to find other messages associated with this
transaction: tid=0x92257580: in your logs. compare it to successful
transactions. Perhaps this failed one is from a packet received on a
particular interface? If this is the case (the interface is different
than other successful packets), perhaps see if there are ANY
successful packets sent on this interface? Perhaps you could share
some logs and/or your configuration file?

Thank you,
Darren Ankney

On Fri, Nov 8, 2024 at 3:19 AM BÖSCH Christian <boesch at fhv.at> wrote:
>
> Hello,
>
>
>
> I periodically get the following error message for some clients. Can anyone give me a hint about what could be the reason for this?
>
>
>
> 2024-11-08T09:06:25.914926+01:00 kea1 kea-dhcp4: ERROR [kea-dhcp4.packets.140628801832640] DHCP4_PACKET_SEND_FAIL [hwtype=1 d8:3a:dd:58:94:0c], cid=[01:d8:3a:dd:58:94:0c], tid=0x92257580: failed to send DHCPv4 packet: pkt4 send failed: sendmsg() returned with an error: Permission denied
>
>
>
> Thanks in advance, Christian
>
> --
> ISC funds the development of this software with paid support subscriptions. Contact us at https://www.isc.org/contact/ <https://www.isc.org/contact/> for more information.
>
> To unsubscribe visit https://lists.isc.org/mailman/listinfo/kea-users <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 <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/ <https://www.isc.org/contact/> for more information.

To unsubscribe visit https://lists.isc.org/mailman/listinfo/kea-users <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 <https://lists.isc.org/mailman/listinfo/kea-users> 





-------------- next part --------------
An HTML attachment was scrubbed...
URL: <https://lists.isc.org/pipermail/kea-users/attachments/20241111/fea9b021/attachment-0001.htm>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: smime.p7s
Type: application/x-pkcs7-signature
Size: 9549 bytes
Desc: not available
URL: <https://lists.isc.org/pipermail/kea-users/attachments/20241111/fea9b021/attachment-0001.bin>

More information about the Kea-users mailing list