<!doctype html>
<html>
<head>
<meta charset="UTF-8">
</head>
<body>
<div>
Here is probably a hint for the problem as seen in the control agent logs:
</div>
<div class="default-style">
HTTP_CLIENT_REQUEST_TIMEOUT_OCCURRED
</div>
<div class="default-style">
and
</div>
<div class="default-style">
HTTP_CONNECTION_STOP
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
Next question is : how/where is the timeout of "10" defined ?
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
2022-01-28 15:10:50.419 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CONNECTION_HANDSHAKE_START start TLS handshake with kea2 with timeout 10
<br>2022-01-28 15:10:50.419 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CLIENT_REQUEST_TIMEOUT_OCCURRED HTTP request timeout occurred when communicating with (unknown address)
<br>2022-01-28 15:10:50.419 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CONNECTION_STOP stopping HTTP connection from (unknown address)
<br>2022-01-28 15:10:50.419 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CONNECTION_HANDSHAKE_START start TLS handshake with kea2 with timeout 10
<br>2022-01-28 15:10:50.420 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CONNECTION_STOP stopping HTTP connection from (unknown address)
<br>2022-01-28 15:10:50.421 INFO [kea-ctrl-agent.http/17978.140214125492416] HTTP_CONNECTION_HANDSHAKE_FAILED TLS handshake with (unknown address) failed with short read
<br>2022-01-28 15:10:50.421 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CONNECTION_STOP stopping HTTP connection from (unknown address)
<br>2022-01-28 15:10:50.494 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTPS_REQUEST_RECEIVE_START start receiving request from kea2
<br>2022-01-28 15:10:50.494 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_DATA_RECEIVED received 146 bytes from kea2
<br>2022-01-28 15:10:50.495 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CLIENT_REQUEST_RECEIVED received HTTP request from kea2
<br>2022-01-28 15:10:50.495 DEBUG [kea-ctrl-agent.http/17978.140214125492416] HTTP_CLIENT_REQUEST_RECEIVED_DETAILS detailed information about well-formed request received from kea2:
<br>
</div>
<blockquote type="cite">
<div>
On 28/01/2022 13:11 Veronique Lefebure <veronique.lefebure@cern.ch> wrote:
</div>
<div>
<br>
</div>
<div>
<br>
</div>
<div class="default-style">
Hi,
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
I would like to get a DEBUG logging each time a server receives a heartbeat from its partner, in a HA setup.
</div>
<div class="default-style">
I have enabled DEBUG level 99 for kea-dhcp4.ha-hooks but it does not provide that info,
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
I am trying to understand why our standby server shows the following every 2 min:
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
2022-01-28 13:02:30.869 WARN [kea-dhcp4.ha-hooks/22827.140145289767104] HA_HEARTBEAT_COMMUNICATIONS_FAILED failed to send heartbeat to kea1 (http://xx.253:9099/): Connection timed out
<br>2022-01-28 13:02:30.869 WARN [kea-dhcp4.ha-hooks/22827.140145289767104] HA_COMMUNICATION_INTERRUPTED communication with kea1 is interrupted
<br>
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
And the primary server then oscillates like this (we have only 1 client for now for test purpose):
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
<div class="default-style">
2022-01-28 13:06:31.887 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_STATE_TRANSITION server transitions from HOT-STANDBY to WAITING state, partner state is PARTNER-DOWN
<br>2022-01-28 13:06:31.887 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LEASE_UPDATES_DISABLED lease updates will not be sent to the partner while in WAITING state
<br>2022-01-28 13:06:31.887 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LOCAL_DHCP_DISABLE local DHCP service is disabled while the kea1 is in the WAITING state
<br>2022-01-28 13:06:31.887 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_STATE_TRANSITION server transitions from WAITING to SYNCING state, partner state is PARTNER-DOWN
<br>2022-01-28 13:06:31.887 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LEASE_UPDATES_DISABLED lease updates will not be sent to the partner while in SYNCING state
<br>2022-01-28 13:06:31.888 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_SYNC_START starting lease database synchronization with kea2
<br>2022-01-28 13:06:31.972 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LEASES_SYNC_LEASE_PAGE_RECEIVED received 1 leases from kea2
<br>2022-01-28 13:06:31.972 DEBUG [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LEASE_SYNC_STALE_LEASE4_SKIP skipping stale lease xx.xx.xx.xx in subnet 2156789248
<br>2022-01-28 13:06:31.975 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_SYNC_SUCCESSFUL lease database synchronization with kea2 completed successfully in 87.082 ms
<br>2022-01-28 13:06:31.976 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_STATE_TRANSITION server transitions from SYNCING to READY state, partner state is PARTNER-DOWN
<br>2022-01-28 13:06:31.976 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LEASE_UPDATES_DISABLED lease updates will not be sent to the partner while in READY state
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
<br>2022-01-28 13:06:52.532 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_STATE_TRANSITION server transitions from READY to HOT-STANDBY state, partner state is HOT-STANDBY
<br>2022-01-28 13:06:52.532 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LEASE_UPDATES_ENABLED lease updates will be sent to the partner while in HOT-STANDBY state
<br>2022-01-28 13:06:52.532 INFO [kea-dhcp4.ha-hooks/12849.140566551173312] HA_LOCAL_DHCP_ENABLE local DHCP service is enabled while the kea1 is in the HOT-STANDBY state
<br>
</div>
<div class="default-style">
<br>
</div>
<div class="default-style">
Thanks.
</div>
</div>_______________________________________________
<br>ISC funds the development of this software with paid support subscriptions. Contact us at https://www.isc.org/contact/ for more information.
<br>
<br>To unsubscribe visit https://lists.isc.org/mailman/listinfo/kea-users.
<br>
<br>Kea-users mailing list
<br>Kea-users@lists.isc.org
<br>https://lists.isc.org/mailman/listinfo/kea-users
<br>
</blockquote>
</body>
</html>