Open Plawasan opened 11 months ago
Hey there @imicknl, @vlebourl, @tetienne, @nyrodev, mind taking a look at this issue as it has been labeled with an integration (overkiz
) you are listed as a code owner for? Thanks!
(message by CodeOwnersMention)
overkiz documentation overkiz source (message by IssueLinks)
Thanks! It seems that your ExecutionRegisteredEvent
is delayed. After we execute a command, we ask the DataUpdateCoordinator to refresh the state. In your case this event is not part of your state yet, and thus the refresh time will not be changed to 1 second. After 30 seconds (default refresh time) your states will be updated.
Not sure how to fix this yet. Will need quite a rewrite of our coordinator/executing mechanism.
I've tested controlling my screens today, the behavior is the same - immediate response of the screen but a 30s delay for the status to be updated in HA.
When you say "my" event is delayed - is this different from what you see on other instances of the same HW, i.e. Tahoma Switch? If there are any settings I can try and change on my Switch, I'm happy to test that.
I can confirm that. both for lights and roller shutters.
I can confirm I have the same issue with Somfy Covers, unfortunately.
Interesting. Which hub do you all have?
During the beta and testing phase, this issue hasn't been mentioned, but it seems like a broader issue. I am a bit busy at the moment, but I hope to have some time later this year to look into this.
TaHoma Switch, running latest fw, v2023.5.4-10
TaHoma Switch, running latest fw, v2023.5.4-10
I use a TaHoma Box (predecessor of TaHoma Switch)
Same issue with covers, TaHoma Switch 2023.5.4-10 Originally reported by me with logs here https://community.home-assistant.io/t/overkiz-integration-local-api-development-testers-topic/485264/204?u=brozikcz
Same here. Using Tahoma Box V2 Premium with firmware 2023.5.4-12 I have only covers with Somfy io motors. In the new Tahoma app, the state is updated immediately.
Hello, I have same problem. Tahoma Switch Update November 2023
+1
Same here! With recent Tahoma Switch.
Currently facing the same issue with the local API with the Tahoma Switch. Cloud API was relatively responsive. Now, my shutters are not reporting back any status during the operation and HA updates quite slowly.
What's interesting, though, is that it immediately reports back position/status if you click the stop button. Otherwise it seems to wait for a certain interval (I guess 30s) before updating, ie letting the shutter go all the way up or down.
@itwtds can you turn on debug mode and share your event log? I wonder what the timings are for your events (like the ones in the start post here). I have seen similar behavior with local API where the integration doesn't poll correctly, because the order/timing of the events is not what we assumed.
@itwtds can you turn on debug mode and share your event log? I wonder what the timings are for your events (like the ones in the start post here). I have seen similar behavior with local API where the integration doesn't poll correctly, because the order/timing of the events is not what we assumed.
Sure thing. I'm currently on travel, but I'll get you the logs shortly.
Thanks
Same here with Tahoma Switch and HA 2024.7 It's working OK in cloud mode, but when using local API, covers status are updated between 15 and 30 secondes later. Reverting back to cloud mode, but hoping someone will solve this issue.
@iMicknl Here is the log for a 30 seconds delay, hope you can help.
2024-07-22 11:21:47.734 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:TargetClosureState', type=<DataType.INTEGER: 1>, value=89)], old_state=None, new_state=None)
2024-07-22 11:21:47.735 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=True)], old_state=None, new_state=None)
2024-07-22 11:21:47.735 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.202 seconds (success: True)
2024-07-22 11:22:17.751 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 45617})], old_state=None, new_state=None)
2024-07-22 11:22:17.752 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=89)], old_state=None, new_state=None)
2024-07-22 11:22:17.753 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:OpenClosedState', type=<DataType.STRING: 3>, value='open')], old_state=None, new_state=None)
2024-07-22 11:22:17.753 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=False)], old_state=None, new_state=None)
2024-07-22 11:22:17.753 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.221 seconds (success: True)
The complete log mwith multiple tries:
2024-07-22 11:17:47.723 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.189 seconds (success: True)
2024-07-22 11:18:17.680 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:TargetClosureState', type=<DataType.INTEGER: 1>, value=72)], old_state=None, new_state=None)
2024-07-22 11:18:17.681 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=True)], old_state=None, new_state=None)
2024-07-22 11:18:17.682 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 36945})], old_state=None, new_state=None)
2024-07-22 11:18:17.682 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=72)], old_state=None, new_state=None)
2024-07-22 11:18:17.683 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=False)], old_state=None, new_state=None)
2024-07-22 11:18:17.683 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.149 seconds (success: True)
2024-07-22 11:18:47.716 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:TargetClosureState', type=<DataType.INTEGER: 1>, value=100)], old_state=None, new_state=None)
2024-07-22 11:18:47.717 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=True)], old_state=None, new_state=None)
2024-07-22 11:18:47.718 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 48587})], old_state=None, new_state=None)
2024-07-22 11:18:47.718 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=95)], old_state=None, new_state=None)
2024-07-22 11:18:47.719 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 49893})], old_state=None, new_state=None)
2024-07-22 11:18:47.719 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=97)], old_state=None, new_state=None)
2024-07-22 11:18:47.720 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 51200})], old_state=None, new_state=None)
2024-07-22 11:18:47.720 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=100)], old_state=None, new_state=None)
2024-07-22 11:18:47.721 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:OpenClosedState', type=<DataType.STRING: 3>, value='closed')], old_state=None, new_state=None)
2024-07-22 11:18:47.721 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=False)], old_state=None, new_state=None)
2024-07-22 11:18:47.722 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.190 seconds (success: True)
2024-07-22 11:19:17.672 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.140 seconds (success: True)
2024-07-22 11:19:47.684 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.152 seconds (success: True)
2024-07-22 11:20:17.678 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.145 seconds (success: True)
2024-07-22 11:20:47.841 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.309 seconds (success: True)
2024-07-22 11:21:17.795 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.263 seconds (success: True)
2024-07-22 11:21:47.734 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:TargetClosureState', type=<DataType.INTEGER: 1>, value=89)], old_state=None, new_state=None)
2024-07-22 11:21:47.735 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=True)], old_state=None, new_state=None)
2024-07-22 11:21:47.735 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.202 seconds (success: True)
2024-07-22 11:22:17.751 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 45617})], old_state=None, new_state=None)
2024-07-22 11:22:17.752 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=89)], old_state=None, new_state=None)
2024-07-22 11:22:17.753 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:OpenClosedState', type=<DataType.STRING: 3>, value='open')], old_state=None, new_state=None)
2024-07-22 11:22:17.753 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=False)], old_state=None, new_state=None)
2024-07-22 11:22:17.753 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.221 seconds (success: True)
2024-07-22 11:22:47.776 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.243 seconds (success: True)
2024-07-22 11:23:17.780 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.248 seconds (success: True)
2024-07-22 11:23:47.665 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.132 seconds (success: True)
2024-07-22 11:24:17.669 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.137 seconds (success: True)
2024-07-22 11:24:47.790 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.258 seconds (success: True)
2024-07-22 11:25:17.767 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.234 seconds (success: True)
2024-07-22 11:25:47.772 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.240 seconds (success: True)
2024-07-22 11:26:17.770 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.238 seconds (success: True)
2024-07-22 11:26:47.982 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.450 seconds (success: True)
2024-07-22 11:27:17.672 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.139 seconds (success: True)
2024-07-22 11:27:47.679 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.146 seconds (success: True)
2024-07-22 11:28:17.678 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.146 seconds (success: True)
2024-07-22 11:28:47.683 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.150 seconds (success: True)
2024-07-22 11:29:17.726 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.193 seconds (success: True)
2024-07-22 11:29:47.696 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.163 seconds (success: True)
2024-07-22 11:30:17.801 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.269 seconds (success: True)
2024-07-22 11:33:08.402 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.050 seconds (success: True)
2024-07-22 11:33:38.717 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:TargetClosureState', type=<DataType.INTEGER: 1>, value=83)], old_state=None, new_state=None)
2024-07-22 11:33:38.718 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=True)], old_state=None, new_state=None)
2024-07-22 11:33:38.718 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='8e42dae6-9a37-47ed-aa50-676764359c09', device_url=None, device_states=[], old_state=None, new_state=None)
2024-07-22 11:33:38.719 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='8e42dae6-9a37-47ed-aa50-676764359c09', device_url=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2024-07-22 11:33:38.719 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 45023})], old_state=None, new_state=None)
2024-07-22 11:33:38.719 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=88)], old_state=None, new_state=None)
2024-07-22 11:33:38.719 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:OpenClosedState', type=<DataType.STRING: 3>, value='open')], old_state=None, new_state=None)
2024-07-22 11:33:38.720 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 43597})], old_state=None, new_state=None)
2024-07-22 11:33:38.720 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=85)], old_state=None, new_state=None)
2024-07-22 11:33:38.720 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 42647})], old_state=None, new_state=None)
2024-07-22 11:33:38.721 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=83)], old_state=None, new_state=None)
2024-07-22 11:33:38.721 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='8e42dae6-9a37-47ed-aa50-676764359c09', device_url=None, device_states=[], old_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>, new_state=<ExecutionState.COMPLETED: 'COMPLETED'>)
2024-07-22 11:33:38.721 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=False)], old_state=None, new_state=None)
2024-07-22 11:33:38.722 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.190 seconds (success: True)
2024-07-22 11:34:08.722 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.190 seconds (success: True)
2024-07-22 11:34:38.718 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.186 seconds (success: True)
2024-07-22 11:35:00.254 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.054 seconds (success: True)
2024-07-22 11:35:29.730 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:TargetClosureState', type=<DataType.INTEGER: 1>, value=100)], old_state=None, new_state=None)
2024-07-22 11:35:29.730 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=True)], old_state=None, new_state=None)
2024-07-22 11:35:29.731 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='1b56984d-95ce-48f4-9598-384518f79e0d', device_url=None, device_states=[], old_state=None, new_state=None)
2024-07-22 11:35:29.731 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='1b56984d-95ce-48f4-9598-384518f79e0d', device_url=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2024-07-22 11:35:29.732 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 48468})], old_state=None, new_state=None)
2024-07-22 11:35:29.732 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=95)], old_state=None, new_state=None)
2024-07-22 11:35:29.732 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 49774})], old_state=None, new_state=None)
2024-07-22 11:35:29.733 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=97)], old_state=None, new_state=None)
2024-07-22 11:35:29.733 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 50962})], old_state=None, new_state=None)
2024-07-22 11:35:29.733 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ClosureState', type=<DataType.INTEGER: 1>, value=100)], old_state=None, new_state=None)
2024-07-22 11:35:29.734 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:OpenClosedState', type=<DataType.STRING: 3>, value='closed')], old_state=None, new_state=None)
2024-07-22 11:35:29.734 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='1b56984d-95ce-48f4-9598-384518f79e0d', device_url=None, device_states=[], old_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>, new_state=<ExecutionState.COMPLETED: 'COMPLETED'>)
2024-07-22 11:35:29.734 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:ManufacturerSettingsState', type=<DataType.JSON_OBJECT: 11>, value={'current_position': 51200})], old_state=None, new_state=None)
2024-07-22 11:35:29.735 DEBUG (MainThread) [homeassistant.components.overkiz] Event(name=<EventName.DEVICE_STATE_CHANGED: 'DeviceStateChangedEvent'>, timestamp=None, setupoid=_CountingAttr(counter=769, _default=None, repr=<function obfuscate_id at 0x7f7ae560c0>, eq=True, order=True, hash=None, init=True, on_setattr=None, alias=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, place_oid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id=None, device_url=io://****-****-5001/7947369, device_states=[EventState(name='core:MovingState', type=<DataType.BOOLEAN: 6>, value=False)], old_state=None, new_state=None)
2024-07-22 11:35:29.735 DEBUG (MainThread) [homeassistant.components.overkiz] Finished fetching device events data in 0.203 seconds (success: True)
Note: the problem occurs on 2 different systems, one on Proxmox, the other one on PI4, both at level OS:12.3 Core 2024.7.2
Thanks! It seems that your ExecutionRegisteredEvent is delayed. After we execute a command, we ask the DataUpdateCoordinator to refresh the state. In your case this event is not part of your state yet, and thus the refresh time will not be changed to 1 second. After 30 seconds (default refresh time) your states will be updated.
Not sure how to fix this yet. Will need quite a rewrite of our coordinator/executing mechanism. https://github.com/home-assistant/core/issues/105162#issuecomment-1843786032
Most likely this is the issue, which is a different behavior of the local API compared to the cloud API. I don't have time (and access to an local Overkiz system) to work on this at the moment.
Same problem here. I have switched to Local API after last HA update which force me to reconfigure Overkiz integration. I have Somfy connexoon IO and 5 cover. Everithing work fine and immediately but when I change the position of the cover, open or close the status update only after 30 seconds
Switched to cloud API and the problem is gone. The entities updates immediately
The problem
When I use the local integration to turn on my pergola lights, the lights do come on within ~1 second however then it takes about half a minute for the state of the HA entity to actually reflect the status, i.e. for the switch to turn on (the same thing happens when I turn them off). This does not happen when controlling the same unit via the the cloud integration, there’s also a delay but much shorter, typically <5s. (again for the state to be reflected in HA, NOT for the actual lights to come on).
What version of Home Assistant Core has the issue?
core-2023.12.0
What was the last working version of Home Assistant Core?
No response
What type of installation are you running?
Home Assistant OS
Integration causing the issue
overkiz
Link to integration documentation on our website
https://www.home-assistant.io/integrations/overkiz/
Diagnostics information
overkiz-452ec9d914d2ea9b9f665d58f8810980-2028-4303-8062-8ef02a85dc3c1c88ee923d16115e5377.json.txt
Example YAML snippet
No response
Anything in the logs that might be useful for us?
Additional information
Issue created based on https://community.home-assistant.io/t/overkiz-integration-local-api-development-testers-topic/485264/285?u=plawa