Hi all smart people
I am not a Zigbee expert, so please forgive any obvious questions.
I’m running Home Assistant 2022.3.5 on an Intel box. All other aspects of HA are the latest release. It’s working very well for most things. I have a ConBee II dongle as the coordinator with 8 OSRAM Smart+ plugs as repeaters and 40 battery operated end devices/sensors. This does not seem a lot, though there are 296 HA entities, including the coordinator and repeaters.
The issue I am having is that the OSRAM Smart+ repeaters become unavailable.
I don’t know what event caused them all to become unavailable around 4:30pm yesterday because I didn’t have logging set up. They all came back after I rebooted the system around 08:00am today. But, as you can see from the history graph, the repeaters go dark occasionally, and can then come back on their own. I now have the logs and have isolated the part where the “U Hallway” plug becomes unavailable and placed it at the end of this post. But to be honest, I don’t know what I am looking at.
The plot below shows the LQI and RSSI values of the plug, as well as the fact that a smoke detector close to the plug, and added to HA via the plug, also becomes unavailable.
2022-03-16 15:10:47 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=climate.guest_bathroom, old_state=<state climate.guest_bathroom=heat_cool; hvac_modes=['off', 'heat_cool'], min_temp=0.5, max_temp=70.0, target_temp_step=0.1, current_temperature=19.5, temperature=6.5, friendly_name=TS - Guest Bathroom, supported_features=1 @ 2022-03-16T12:51:47.795703+00:00>, new_state=<state climate.guest_bathroom=heat_cool; hvac_modes=['off', 'heat_cool'], min_temp=0.5, max_temp=70.0, target_temp_step=0.1, current_temperature=20.0, temperature=6.5, friendly_name=TS - Guest Bathroom, supported_features=1 @ 2022-03-16T12:51:47.795703+00:00>>
2022-03-16 15:10:51 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=climate.guest_bathroom, old_state=<state climate.guest_bathroom=heat_cool; hvac_modes=['off', 'heat_cool'], min_temp=0.5, max_temp=70.0, target_temp_step=0.1, current_temperature=20.0, temperature=6.5, friendly_name=TS - Guest Bathroom, supported_features=1 @ 2022-03-16T12:51:47.795703+00:00>, new_state=<state climate.guest_bathroom=heat_cool; hvac_modes=['off', 'heat_cool'], min_temp=0.5, max_temp=70.0, target_temp_step=0.1, current_temperature=19.5, temperature=6.5, friendly_name=TS - Guest Bathroom, supported_features=1 @ 2022-03-16T12:51:47.795703+00:00>>
2022-03-16 15:10:52 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.pool_power, old_state=<state sensor.pool_power=13.1; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Pool - Power @ 2022-03-16T15:10:37.170083+00:00>, new_state=<state sensor.pool_power=13.3; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Pool - Power @ 2022-03-16T15:10:52.187409+00:00>>
2022-03-16 15:10:52 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.pool_voltage, old_state=<state sensor.pool_voltage=225.8; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Pool - Voltage @ 2022-03-16T15:10:37.171589+00:00>, new_state=<state sensor.pool_voltage=226.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Pool - Voltage @ 2022-03-16T15:10:52.189020+00:00>>
2022-03-16 15:10:52 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.fridge_power, old_state=<state sensor.fridge_power=18.1; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Fridge - Power @ 2022-03-16T15:10:37.172414+00:00>, new_state=<state sensor.fridge_power=17.8; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Fridge - Power @ 2022-03-16T15:10:52.189863+00:00>>
2022-03-16 15:10:52 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.fridge_voltage, old_state=<state sensor.fridge_voltage=225.8; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Fridge - Voltage @ 2022-03-16T15:10:37.173536+00:00>, new_state=<state sensor.fridge_voltage=226.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Fridge - Voltage @ 2022-03-16T15:10:52.190998+00:00>>
2022-03-16 15:10:52 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_power, old_state=<state sensor.house_power=2649.1; friendly_name=House - Power @ 2022-03-16T15:10:40.342684+00:00>, new_state=<state sensor.house_power=2648.9; friendly_name=House - Power @ 2022-03-16T15:10:52.193220+00:00>>
2022-03-16 15:10:53 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event zha_event[L]: device_ieee=7c:b0:3e:aa:0a:0a:60:38, unique_id=7c:b0:3e:aa:0a:0a:60:38, device_id=71dd37a5f5f0a4087603bf1c94789c4f, device_event_type=device_offline>
2022-03-16 15:10:53 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=button.plug_upstairs_hallway_identify, old_state=<state button.plug_upstairs_hallway_identify=unknown; device_class=update, friendly_name=Plug - Upstairs Hallway - Identify @ 2022-03-16T14:33:08.309421+00:00>, new_state=<state button.plug_upstairs_hallway_identify=unavailable; device_class=update, friendly_name=Plug - Upstairs Hallway - Identify @ 2022-03-16T15:10:53.595083+00:00>>
2022-03-16 15:10:53 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.plug_upstairs_hallway_rssi, old_state=<state sensor.plug_upstairs_hallway_rssi=-89; icon=mdi:signal-distance-variant, friendly_name=Plug - Upstairs Hallway - RSSI @ 2022-03-16T15:08:23.847879+00:00>, new_state=<state sensor.plug_upstairs_hallway_rssi=unavailable; icon=mdi:signal-distance-variant, friendly_name=Plug - Upstairs Hallway - RSSI @ 2022-03-16T15:10:53.595912+00:00>>
2022-03-16 15:10:53 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.plug_upstairs_hallway_lqi, old_state=<state sensor.plug_upstairs_hallway_lqi=26; friendly_name=Plug - Upstairs Hallway - LQI @ 2022-03-16T15:08:23.848713+00:00>, new_state=<state sensor.plug_upstairs_hallway_lqi=unavailable; friendly_name=Plug - Upstairs Hallway - LQI @ 2022-03-16T15:10:53.596652+00:00>>
2022-03-16 15:10:53 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=switch.plug_upstairs_hallway, old_state=<state switch.plug_upstairs_hallway=off; icon=mdi:power-plug, friendly_name=Plug - Upstairs Hallway @ 2022-03-16T14:33:07.116058+00:00>, new_state=<state switch.plug_upstairs_hallway=unavailable; icon=mdi:power-plug, friendly_name=Plug - Upstairs Hallway @ 2022-03-16T15:10:53.597349+00:00>>
2022-03-16 15:10:53 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.plug_laundry_rssi, old_state=<state sensor.plug_laundry_rssi=-76; icon=mdi:signal-distance-variant, friendly_name=Plug - Laundry - RSSI @ 2022-03-16T15:07:42.615690+00:00>, new_state=<state sensor.plug_laundry_rssi=-75; icon=mdi:signal-distance-variant, friendly_name=Plug - Laundry - RSSI @ 2022-03-16T15:10:53.845354+00:00>>
2022-03-16 15:10:53 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.plug_laundry_lqi, old_state=<state sensor.plug_laundry_lqi=143; icon=mdi:signal-distance-variant, friendly_name=Plug - Laundry - LQI @ 2022-03-16T15:07:42.616556+00:00>, new_state=<state sensor.plug_laundry_lqi=151; icon=mdi:signal-distance-variant, friendly_name=Plug - Laundry - LQI @ 2022-03-16T15:10:53.846404+00:00>>
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_INDICATION|2: 170>, 0]
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_indication (1, 1)
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] APS data indication response: [28, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x0000>, 1, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x374d>, 35, 260, 10, b'\x00\x95\x00\x00\x00', 0, 175, 79, 117, 248, 39, 0, -84]
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy.zcl] [0x374d:35:0x000a] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=False disable_default_response=False> manufacturer=None tsn=149 command_id=Command.Read_Attributes>
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy.zcl] [0x374d:35:0x000a] ZCL request 0x0000: [[0]]
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.zigbee.application] Sending Zigbee request with tsn 149 under 0 request id, data: b'189501000000e27dbac429'
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] 'aps_data_indication' response from <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x374d>, ep: 35, profile: 0x0104, cluster_id: 0x000a, data: b'0095000000'
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_request (26, 0, 0, <DeconzAddressEndpoint address_mode=2 address=0x374D endpoint=35>, 260, 10, 1, b'\x18\x95\x01\x00\x00\x00\xe2}\xba\xc4)', 2, 0)
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] APS data request response: [2, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, 0]
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_CONFIRM|2: 166>, 0]
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_confirm (0,)
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] APS data confirm response for request with id 0: 00
2022-03-16 15:10:53 DEBUG (MainThread) [zigpy_deconz.api] Request id: 0x00 'aps_data_confirm' for <DeconzAddressEndpoint address_mode=ADDRESS_MODE.NWK address=0x374d endpoint=35>, status: 0x00
2022-03-16 15:10:54 DEBUG (MainThread) [zigpy_deconz.api] Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_INDICATION|2: 170>, 0]
2022-03-16 15:10:54 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_indication (1, 1)
2022-03-16 15:10:54 DEBUG (MainThread) [zigpy_deconz.api] APS data indication response: [32, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x0000>, 1, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x374d>, 35, 260, 1280, b'\x19\x96\x000\x00\x00\x00\xff\xff', 0, 175, 79, 117, 248, 39, 0, -84]
2022-03-16 15:10:54 DEBUG (MainThread) [zigpy.zcl] [0x374d:35:0x0500] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=CLUSTER_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=150 command_id=0>
2022-03-16 15:10:54 DEBUG (MainThread) [zigpy.zcl] [0x374d:35:0x0500] ZCL request 0x0000: [<ZoneStatus.Restore_reports|Supervision_reports: 48>, <Optional.0: 0>, 0, 65535]
2022-03-16 15:10:54 DEBUG (MainThread) [homeassistant.components.zha.core.channels.base] [0x374D:35:0x0500]: Updated alarm state: ZoneStatus.0
2022-03-16 15:10:54 DEBUG (MainThread) [zigpy_deconz.api] 'aps_data_indication' response from <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x374d>, ep: 35, profile: 0x0104, cluster_id: 0x0500, data: b'19960030000000ffff'
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.mains_power, old_state=<state sensor.mains_power=4758.8; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Mains - Power @ 2022-03-16T15:10:40.326482+00:00>, new_state=<state sensor.mains_power=4745.1; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Mains - Power @ 2022-03-16T15:10:55.339894+00:00>>
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.mains_voltage, old_state=<state sensor.mains_voltage=229.1; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Mains - Voltage @ 2022-03-16T15:10:40.327967+00:00>, new_state=<state sensor.mains_voltage=229.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Mains - Voltage @ 2022-03-16T15:10:55.341400+00:00>>
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_power_total, old_state=<state sensor.house_power_total=2662.2; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=House - Power - Total @ 2022-03-16T15:10:40.329603+00:00>, new_state=<state sensor.house_power_total=2675.6; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=House - Power - Total @ 2022-03-16T15:10:55.342387+00:00>>
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_voltage_total, old_state=<state sensor.house_voltage_total=229.1; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=House - Voltage - Total @ 2022-03-16T15:10:40.330748+00:00>, new_state=<state sensor.house_voltage_total=229.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=House - Voltage - Total @ 2022-03-16T15:10:55.343523+00:00>>
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.laundry_power, old_state=<state sensor.laundry_power=2096.6; friendly_name=Laundry - Power @ 2022-03-16T15:10:40.335426+00:00>, new_state=<state sensor.laundry_power=2069.5; friendly_name=Laundry - Power @ 2022-03-16T15:10:55.345901+00:00>>
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.laundry_voltage, old_state=<state sensor.laundry_voltage=229.1; friendly_name=Laundry - Voltage @ 2022-03-16T15:10:40.337235+00:00>, new_state=<state sensor.laundry_voltage=229.2; friendly_name=Laundry - Voltage @ 2022-03-16T15:10:55.347461+00:00>>
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_power, old_state=<state sensor.house_power=2648.9; friendly_name=House - Power @ 2022-03-16T15:10:52.193220+00:00>, new_state=<state sensor.house_power=2662.3; friendly_name=House - Power @ 2022-03-16T15:10:55.353718+00:00>>
2022-03-16 15:10:55 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_voltage_2, old_state=<state sensor.house_voltage_2=229.1; friendly_name=House - Voltage @ 2022-03-16T15:10:40.344385+00:00>, new_state=<state sensor.house_voltage_2=229.2; friendly_name=House - Voltage @ 2022-03-16T15:10:55.355617+00:00>>
2022-03-16 15:10:58 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0x29C7](Plug 01): Attempting to checkin with device - missed checkins: 1
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.zigbee.application] Sending Zigbee request with tsn 1 under 2 request id, data: b'0001000400'
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_request (20, 2, 0, <DeconzAddressEndpoint address_mode=2 address=0x29C7 endpoint=3>, 260, 0, 1, b'\x00\x01\x00\x04\x00', 2, 0)
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] APS data request response: [2, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, 2]
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_CONFIRM|2: 166>, 0]
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_confirm (0,)
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] APS data confirm response for request with id 2: 00
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] Request id: 0x02 'aps_data_confirm' for <DeconzAddressEndpoint address_mode=ADDRESS_MODE.NWK address=0x29c7 endpoint=3>, status: 0x00
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_INDICATION|2: 170>, 0]
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_indication (1, 1)
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] APS data indication response: [36, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x0000>, 1, <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x29c7>, 3, 260, 0, b'\x18\x01\x01\x04\x00\x00B\x05OSRAM', 0, 175, 63, 119, 248, 39, 0, -86]
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy.zcl] [0x29c7:3:0x0000] ZCL deserialize: <ZCLHeader frame_control=<FrameControl frame_type=GLOBAL_COMMAND manufacturer_specific=False is_reply=True disable_default_response=True> manufacturer=None tsn=1 command_id=Command.Read_Attributes_rsp>
2022-03-16 15:10:58 DEBUG (MainThread) [zigpy_deconz.api] 'aps_data_indication' response from <DeconzAddress address_mode=ADDRESS_MODE.NWK address=0x29c7>, ep: 3, profile: 0x0104, cluster_id: 0x0000, data: b'18010104000042054f5352414d'
2022-03-16 15:11:00 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.time, old_state=<state sensor.time=15:10; icon=mdi:clock, friendly_name=Time @ 2022-03-16T15:10:00.004349+00:00>, new_state=<state sensor.time=15:11; icon=mdi:clock, friendly_name=Time @ 2022-03-16T15:11:00.002940+00:00>>
2022-03-16 15:11:00 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.date_time_iso, old_state=<state sensor.date_time_iso=2022-03-16T15:10:00; icon=mdi:calendar-clock, friendly_name=Date & Time (ISO) @ 2022-03-16T15:10:00.005433+00:00>, new_state=<state sensor.date_time_iso=2022-03-16T15:11:00; icon=mdi:calendar-clock, friendly_name=Date & Time (ISO) @ 2022-03-16T15:11:00.004448+00:00>>
2022-03-16 15:11:00 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.date_time, old_state=<state sensor.date_time=2022-03-16, 15:10; icon=mdi:calendar-clock, friendly_name=Date & Time @ 2022-03-16T15:10:00.002904+00:00>, new_state=<state sensor.date_time=2022-03-16, 15:11; icon=mdi:calendar-clock, friendly_name=Date & Time @ 2022-03-16T15:11:00.011408+00:00>>
2022-03-16 15:11:00 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.load_1m, old_state=<state sensor.load_1m=0.27; state_class=measurement, icon=mdi:cpu-64-bit, friendly_name=Load (1m) @ 2022-03-16T15:10:45.506940+00:00>, new_state=<state sensor.load_1m=0.43; state_class=measurement, icon=mdi:cpu-64-bit, friendly_name=Load (1m) @ 2022-03-16T15:11:00.510226+00:00>>
2022-03-16 15:11:00 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.load_5m, old_state=<state sensor.load_5m=0.23; state_class=measurement, icon=mdi:cpu-64-bit, friendly_name=Load (5m) @ 2022-03-16T15:10:45.507954+00:00>, new_state=<state sensor.load_5m=0.26; state_class=measurement, icon=mdi:cpu-64-bit, friendly_name=Load (5m) @ 2022-03-16T15:11:00.511248+00:00>>
2022-03-16 15:11:00 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.load_15m, old_state=<state sensor.load_15m=0.15; state_class=measurement, icon=mdi:cpu-64-bit, friendly_name=Load (15m) @ 2022-03-16T15:10:00.505778+00:00>, new_state=<state sensor.load_15m=0.16; state_class=measurement, icon=mdi:cpu-64-bit, friendly_name=Load (15m) @ 2022-03-16T15:11:00.511990+00:00>>
2022-03-16 15:11:00 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.processor_use, old_state=<state sensor.processor_use=2; state_class=measurement, unit_of_measurement=%, icon=mdi:cpu-64-bit, friendly_name=Processor use @ 2022-03-16T15:10:45.508870+00:00>, new_state=<state sensor.processor_use=3; state_class=measurement, unit_of_measurement=%, icon=mdi:cpu-64-bit, friendly_name=Processor use @ 2022-03-16T15:11:00.512727+00:00>>
2022-03-16 15:11:02 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.eaton5s_load, old_state=<state sensor.eaton5s_load=5; state_class=measurement, unit_of_measurement=%, icon=mdi:gauge, friendly_name=Eaton5S Load @ 2022-03-16T15:10:02.034558+00:00>, new_state=<state sensor.eaton5s_load=1; state_class=measurement, unit_of_measurement=%, icon=mdi:gauge, friendly_name=Eaton5S Load @ 2022-03-16T15:11:02.013650+00:00>>
2022-03-16 15:11:02 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.eaton5s_input_voltage, old_state=<state sensor.eaton5s_input_voltage=224.0; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Eaton5S Input Voltage @ 2022-03-16T14:59:02.014819+00:00>, new_state=<state sensor.eaton5s_input_voltage=220.0; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Eaton5S Input Voltage @ 2022-03-16T15:11:02.015390+00:00>>
2022-03-16 15:11:07 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.pool_power, old_state=<state sensor.pool_power=13.3; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Pool - Power @ 2022-03-16T15:10:52.187409+00:00>, new_state=<state sensor.pool_power=13.1; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Pool - Power @ 2022-03-16T15:11:07.197673+00:00>>
2022-03-16 15:11:07 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.pool_voltage, old_state=<state sensor.pool_voltage=226.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Pool - Voltage @ 2022-03-16T15:10:52.189020+00:00>, new_state=<state sensor.pool_voltage=225.9; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Pool - Voltage @ 2022-03-16T15:11:07.199181+00:00>>
2022-03-16 15:11:07 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.fridge_power, old_state=<state sensor.fridge_power=17.8; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Fridge - Power @ 2022-03-16T15:10:52.189863+00:00>, new_state=<state sensor.fridge_power=18.0; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Fridge - Power @ 2022-03-16T15:11:07.199997+00:00>>
2022-03-16 15:11:07 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.fridge_voltage, old_state=<state sensor.fridge_voltage=226.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Fridge - Voltage @ 2022-03-16T15:10:52.190998+00:00>, new_state=<state sensor.fridge_voltage=225.9; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Fridge - Voltage @ 2022-03-16T15:11:07.201127+00:00>>
2022-03-16 15:11:07 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_power, old_state=<state sensor.house_power=2662.3; friendly_name=House - Power @ 2022-03-16T15:10:55.353718+00:00>, new_state=<state sensor.house_power=2662.5; friendly_name=House - Power @ 2022-03-16T15:11:07.203333+00:00>>
2022-03-16 15:11:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.switches_pool_pump_current, old_state=<state sensor.switches_pool_pump_current=0.0; state_class=measurement, unit_of_measurement=A, device_class=current, friendly_name=Switches - Pool Pump Current @ 2022-03-16T15:09:51.988867+00:00>, new_state=<state sensor.switches_pool_pump_current=0.035; state_class=measurement, unit_of_measurement=A, device_class=current, friendly_name=Switches - Pool Pump Current @ 2022-03-16T15:11:09.042134+00:00>>
2022-03-16 15:11:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.switches_pool_pump_power, old_state=<state sensor.switches_pool_pump_power=0.0; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Switches - Pool Pump Power @ 2022-03-16T15:09:51.989971+00:00>, new_state=<state sensor.switches_pool_pump_power=1.7; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Switches - Pool Pump Power @ 2022-03-16T15:11:09.043265+00:00>>
2022-03-16 15:11:09 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.switches_pool_pump_voltage, old_state=<state sensor.switches_pool_pump_voltage=221.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Switches - Pool Pump Voltage @ 2022-03-16T15:10:45.041909+00:00>, new_state=<state sensor.switches_pool_pump_voltage=220.7; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Switches - Pool Pump Voltage @ 2022-03-16T15:11:09.044042+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.mains_power, old_state=<state sensor.mains_power=4745.1; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Mains - Power @ 2022-03-16T15:10:55.339894+00:00>, new_state=<state sensor.mains_power=4923.1; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=Mains - Power @ 2022-03-16T15:11:10.307246+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.mains_energy, old_state=<state sensor.mains_energy=8446.01; state_class=total_increasing, unit_of_measurement=kWh, device_class=energy, friendly_name=Mains - Energy @ 2022-03-16T15:10:01.231134+00:00>, new_state=<state sensor.mains_energy=8446.07; state_class=total_increasing, unit_of_measurement=kWh, device_class=energy, friendly_name=Mains - Energy @ 2022-03-16T15:11:10.308429+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.mains_voltage, old_state=<state sensor.mains_voltage=229.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Mains - Voltage @ 2022-03-16T15:10:55.341400+00:00>, new_state=<state sensor.mains_voltage=228.5; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=Mains - Voltage @ 2022-03-16T15:11:10.309433+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_power_total, old_state=<state sensor.house_power_total=2675.6; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=House - Power - Total @ 2022-03-16T15:10:55.342387+00:00>, new_state=<state sensor.house_power_total=2872.5; state_class=measurement, unit_of_measurement=W, device_class=power, friendly_name=House - Power - Total @ 2022-03-16T15:11:10.310400+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_energy_total, old_state=<state sensor.house_energy_total=3129.14; state_class=total_increasing, unit_of_measurement=kWh, device_class=energy, friendly_name=House - Energy - Total @ 2022-03-16T15:07:07.532224+00:00>, new_state=<state sensor.house_energy_total=3129.16; state_class=total_increasing, unit_of_measurement=kWh, device_class=energy, friendly_name=House - Energy - Total @ 2022-03-16T15:11:10.311235+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_voltage_total, old_state=<state sensor.house_voltage_total=229.2; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=House - Voltage - Total @ 2022-03-16T15:10:55.343523+00:00>, new_state=<state sensor.house_voltage_total=228.5; state_class=measurement, unit_of_measurement=V, device_class=voltage, friendly_name=House - Voltage - Total @ 2022-03-16T15:11:10.312225+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.laundry_power, old_state=<state sensor.laundry_power=2069.5; friendly_name=Laundry - Power @ 2022-03-16T15:10:55.345901+00:00>, new_state=<state sensor.laundry_power=2050.6; friendly_name=Laundry - Power @ 2022-03-16T15:11:10.316355+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.mains_energy_cost, old_state=<state sensor.mains_energy_cost=1.28338000000017; state_class=total, last_reset=2022-03-16T12:51:48.185025+00:00, unit_of_measurement=EUR, device_class=monetary, friendly_name=sensor Cost @ 2022-03-16T15:10:01.238387+00:00>, new_state=<state sensor.mains_energy_cost=1.29406000000008; state_class=total, last_reset=2022-03-16T12:51:48.185025+00:00, unit_of_measurement=EUR, device_class=monetary, friendly_name=sensor Cost @ 2022-03-16T15:11:10.317619+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.laundry_energy, old_state=<state sensor.laundry_energy=5316.87; friendly_name=Laundry - Energy @ 2022-03-16T15:10:01.239885+00:00>, new_state=<state sensor.laundry_energy=5316.91; friendly_name=Laundry - Energy @ 2022-03-16T15:11:10.319141+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.laundry_voltage, old_state=<state sensor.laundry_voltage=229.2; friendly_name=Laundry - Voltage @ 2022-03-16T15:10:55.347461+00:00>, new_state=<state sensor.laundry_voltage=228.5; friendly_name=Laundry - Voltage @ 2022-03-16T15:11:10.323914+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_power, old_state=<state sensor.house_power=2662.5; friendly_name=House - Power @ 2022-03-16T15:11:07.203333+00:00>, new_state=<state sensor.house_power=2859.4; friendly_name=House - Power @ 2022-03-16T15:11:10.330622+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_energy, old_state=<state sensor.house_energy=2216.78; friendly_name=House - Energy @ 2022-03-16T15:07:07.555847+00:00>, new_state=<state sensor.house_energy=2216.8; friendly_name=House - Energy @ 2022-03-16T15:11:10.333326+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.core] Bus:Handling <Event state_changed[L]: entity_id=sensor.house_voltage_2, old_state=<state sensor.house_voltage_2=229.2; friendly_name=House - Voltage @ 2022-03-16T15:10:55.355617+00:00>, new_state=<state sensor.house_voltage_2=228.5; friendly_name=House - Voltage @ 2022-03-16T15:11:10.334824+00:00>>
2022-03-16 15:11:10 DEBUG (MainThread) [homeassistant.components.zha.core.device] [0xF9B2](Plug 01): Attempting to checkin with device - missed checkins: 1
2022-03-16 15:11:10 DEBUG (MainThread) [zigpy_deconz.zigbee.application] Sending Zigbee request with tsn 3 under 4 request id, data: b'0003000400'
2022-03-16 15:11:10 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_request (20, 4, 0, <DeconzAddressEndpoint address_mode=2 address=0xF9B2 endpoint=3>, 260, 0, 1, b'\x00\x03\x00\x04\x00', 2, 0)
2022-03-16 15:11:10 DEBUG (MainThread) [zigpy_deconz.api] APS data request response: [2, <DeviceState.APSDE_DATA_REQUEST_SLOTS_AVAILABLE|2: 34>, 4]
2022-03-16 15:11:10 DEBUG (MainThread) [zigpy_deconz.api] Device state changed response: [<DeviceState.128|APSDE_DATA_REQUEST_SLOTS_AVAILABLE|APSDE_DATA_CONFIRM|2: 166>, 0]
2022-03-16 15:11:10 DEBUG (MainThread) [zigpy_deconz.api] Command Command.aps_data_confirm (0,)
2022-03-16 15:11:10 DEBUG (MainThread) [zigpy_deconz.api] APS data confirm response for request with id 4: e9
2022-03-16 15:11:10 DEBUG (MainThread) [zigpy_deconz.api] Request id: 0x04 'aps_data_confirm' for <DeconzAddressEndpoint address_mode=ADDRESS_MODE.NWK address=0xf9b2 endpoint=3>, status: 0xe9