iMicknl / ha-tahoma

Custom component for Home Assistant to interact with smart devices via Somfy TaHoma or other OverKiz based API's.
MIT License
151 stars 30 forks source link

Retrying setup: Too many requests, try again later for OVerkiz (by somfy) #586

Closed p2544 closed 2 years ago

p2544 commented 2 years ago

Did you read the instructions?

The problem

I got a connexoon devices, previously working fine with my RTS motors just a 2 month ago, everything seem to be not response, Checking in Home assistant integration and found that it got an error, please advise how to fix this Screenshot 2021-09-25 063010 Screenshot 2021-09-25 063120 Screenshot 2021-09-25 063554 Screenshot 2021-09-25 063635 Screenshot 2021-09-25 064551 .

What version of this integration (ha-tahoma) has the issue?

latest on

What version of Home Assistant Core has the issue?

core-2021.8.8 and core-2021.9.7

Which gateway / hub do you use?

connexoon

Device model

No response

Home Assistant log

Unable to find referenced entities remote.ae_raembaan_remote
6:54:54 AM – (WARNING) helpers/service.py - message first occurred at September 24, 2021, 8:19:12 PM and shows up 5 times
Too many requests, try again later : login with xxxxx@gmail.com
6:22:47 AM – (ERROR) Somfy TaHoma (custom integration) - message first occurred at 6:01:04 AM and shows up 11 times
[547656722224] Too many requests, try again later : login with xxxxx@gmail.com
6:12:12 AM – (ERROR) Home Assistant WebSocket API (custom integration) - message first occurred at 6:01:25 AM and shows up 2 times
Error doing job: Task exception was never retrieved
6:06:34 AM – (ERROR) components/tuya/__init__.py - message first occurred at 5:08:51 AM and shows up 2 times
Error fetching device events data: Too many requests, try again later.
4:16:25 AM – (ERROR) Somfy TaHoma (custom integration) - message first occurred at September 24, 2021, 8:18:37 PM and shows up 5 times

Additional information

No response

iMicknl commented 2 years ago

Could you give https://github.com/iMicknl/ha-tahoma/archive/refs/heads/feature/remove-custom-interval.zip a try? Extract this file and place custom_components/tahoma in your custom_components folder.

We have seen this issue more often on the Oceania server, where users only add RTS devices. Hopefully this version will solve this issue.

tetienne commented 2 years ago

By the way, if you have only RTS devices, I will glad if you can enable the debug logging as explain in the readme, and copy paste here the logs related to this integration.

p2544 commented 2 years ago

Could you give https://github.com/iMicknl/ha-tahoma/archive/refs/heads/feature/remove-custom-interval.zip a try? Extract this file and place custom_components/tahoma in your custom_components folder.

We have seen this issue more often on the Oceania server, where users only add RTS devices. Hopefully this version will solve this issue.

yep, it working now iMicknl, thanks for your help image

p2544 commented 2 years ago

just succeed at the 1st try, lately it doesn't work again Screenshot 2021-09-26 152954 Screenshot 2021-09-26 152911

iMicknl commented 2 years ago

@p2544 could you please turn on debug logging and share your full log?

p2544 commented 2 years ago

@p2544 could you please turn on debug logging and share your full log?

already add some logger in configuration.yam + l restart server. is this the log screen you want to check?

image

iMicknl commented 2 years ago

@p2544 yes indeed. You can copy the full log and past it here between ```.

Currently there is nothing in your log yet, however if you face those issues, there should be more information in the log. By the way, I see you are still using configuration in YAML (configuration.yaml), I would remove the tahoma key there as well and just use the Config Flow.

p2544 commented 2 years ago

here is my current configuration.yaml , is it ok? if not what should I fix or add? Screenshot 2021-09-26 202611

iMicknl commented 2 years ago

Your configuration is fine, however I would remove line 20 to 27, since this is very old.

Now reboot and wait for a while, it should fill your log after a while and you can copy and paste it here.

p2544 commented 2 years ago

Logger: libav.tcp Source: components/stream/worker.py:321 First occurred: 8:45:57 PM (10 occurrences) Last logged: 8:53:55 PM

Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable

p2544 commented 2 years ago
2021-09-26 20:45:14 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration tuya_v2 which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:14 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:14 WARNING (SyncWorker_2) [homeassistant.loader] We found a custom integration tahoma which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:14 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration connector which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:57 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:46:08 DEBUG (MainThread) [custom_components.tahoma.config_flow] DHCP discovery detected gateway ****-****-6362
2021-09-26 20:46:08 DEBUG (MainThread) [custom_components.tahoma.config_flow] Gateway ****-****-6362 is already configured
2021-09-26 20:46:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:46:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:47:06 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:47:49 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:48:42 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:49:46 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:50:59 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:52:22 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:53:55 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
iMicknl commented 2 years ago

Do you currently have these issues, and this is the only thing you see in the log? Have you set up the TaHoma integration? Because I don't see any errors related to custom_components.tahoma in your log.

p2544 commented 2 years ago

I working right now, I need to wait for tomorrow because time here in Bangkok is 23:30 already. however thanks for your help, let see how it goes again. [image: image.png]

On Sun, 26 Sept 2021 at 22:09, Mick Vleeshouwer @.***> wrote:

Do you currently have these issues, and this is the only thing you see in the log? Have you set up the TaHoma integration? Because I don't see any errors related to custom_components.tahoma in your log.

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/iMicknl/ha-tahoma/issues/586#issuecomment-927321405, or unsubscribe https://github.com/notifications/unsubscribe-auth/AF2IMAERDKZEN7EAVEGPZKLUD4ZTLANCNFSM5EXDCGPQ . Triage notifications on the go with GitHub Mobile for iOS https://apps.apple.com/app/apple-store/id1477376905?ct=notification-email&mt=8&pt=524675 or Android https://play.google.com/store/apps/details?id=com.github.android&referrer=utm_campaign%3Dnotification-email%26utm_medium%3Demail%26utm_source%3Dgithub.

p2544 commented 2 years ago

now it seem that the button are all disable again image

This error originated from a custom integration.

Logger: custom_components.tahoma Source: helpers/update_coordinator.py:219 Integration: Overkiz (by Somfy) First occurred: 11:26:11 PM (3 occurrences) Last logged: 11:28:32 PM

Error fetching device events data: Too many requests, try again later.

p2544 commented 2 years ago

here is all the full log

2021-09-26 20:45:14 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration tuya_v2 which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:14 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:14 WARNING (SyncWorker_2) [homeassistant.loader] We found a custom integration tahoma which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:14 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration connector which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-26 20:45:57 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:46:08 DEBUG (MainThread) [custom_components.tahoma.config_flow] DHCP discovery detected gateway ****-****-6362
2021-09-26 20:46:08 DEBUG (MainThread) [custom_components.tahoma.config_flow] Gateway ****-****-6362 is already configured
2021-09-26 20:46:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:46:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:47:06 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:47:49 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:48:42 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:49:46 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:50:59 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:52:22 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:53:55 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:55:38 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:57:31 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 20:59:34 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:01:47 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:04:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:06:43 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:09:26 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:12:19 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:15:23 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:18:36 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:21:59 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:25:32 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:29:15 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:33:08 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:37:11 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:41:24 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:45:47 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:50:20 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:55:03 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 21:59:56 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:05:00 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:10:13 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:15:36 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:21:09 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:26:52 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:32:45 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:38:48 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:45:01 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:51:24 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 22:57:57 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 23:04:40 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 23:11:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 23:14:11 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:14:11 DEBUG (MainThread) [custom_components.tahoma] Added device (Device(attributes=States(_states=[State(name='rts:diy', type=<DataType.BOOLEAN: 6>, value=False)]), available=True, enabled=True, label='หน้าต่างม้วนแม่บ้าน', deviceurl=rts://****-****-6362/16730022, controllable_name='rts:RollerShutterRTSComponent', definition=Definition(commands=CommandDefinitions(_commands=[CommandDefinition(command_name='close', nparams=1), CommandDefinition(command_name='down', nparams=1), CommandDefinition(command_name='identify', nparams=0), CommandDefinition(command_name='my', nparams=1), CommandDefinition(command_name='open', nparams=1), CommandDefinition(command_name='rest', nparams=1), CommandDefinition(command_name='stop', nparams=1), CommandDefinition(command_name='test', nparams=0), CommandDefinition(command_name='up', nparams=1), CommandDefinition(command_name='openConfiguration', nparams=1)]), states=[], widget_name='UpDownRollerShutter', ui_class='RollerShutter', qualified_name='rts:RollerShutterRTSComponent'), data_properties=None, widget='UpDownRollerShutter', ui_class='RollerShutter', states=States(_states=[]), type=<ProductType.ACTUATOR: 1>, placeoid='6133b4a0-f514-4553-b635-d1b7beb7e7b2'))
2021-09-26 23:14:11 DEBUG (MainThread) [custom_components.tahoma] Added device (Device(attributes=States(_states=[State(name='rts:diy', type=<DataType.BOOLEAN: 6>, value=False)]), available=True, enabled=True, label='ประตูม้วนครัว', deviceurl=rts://****-****-6362/16749917, controllable_name='rts:RollerShutterRTSComponent', definition=Definition(commands=CommandDefinitions(_commands=[CommandDefinition(command_name='close', nparams=1), CommandDefinition(command_name='down', nparams=1), CommandDefinition(command_name='identify', nparams=0), CommandDefinition(command_name='my', nparams=1), CommandDefinition(command_name='open', nparams=1), CommandDefinition(command_name='rest', nparams=1), CommandDefinition(command_name='stop', nparams=1), CommandDefinition(command_name='test', nparams=0), CommandDefinition(command_name='up', nparams=1), CommandDefinition(command_name='openConfiguration', nparams=1)]), states=[], widget_name='UpDownRollerShutter', ui_class='RollerShutter', qualified_name='rts:RollerShutterRTSComponent'), data_properties=None, widget='UpDownRollerShutter', ui_class='RollerShutter', states=States(_states=[]), type=<ProductType.ACTUATOR: 1>, placeoid='6133b4a0-f514-4553-b635-d1b7beb7e7b2'))
2021-09-26 23:14:11 DEBUG (MainThread) [custom_components.tahoma] Added gateway (Gateway(partners=[Partner(activated=True, name='Somfy Thailand', id=somfy-thailand, status='OWNER')], functions='INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS', sub_type=<GatewaySubType.TAHOMA_BASIC: 1>, id=****-****-6362, gateway_id=NOTHING, alive=True, mode='ACTIVE', placeoid='6133b4a0-f514-4553-b635-d1b7beb7e7b2', time_reliable=True, connectivity=Connectivity(status='OK', protocol_version='2021.2.4'), up_to_date=True, update_status=<UpdateBoxStatus.UP_TO_DATE: 'UP_TO_DATE'>, sync_in_progress=False, type=<GatewayType.CONNEXOON_RTS: 53>))
2021-09-26 23:14:41 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.099 seconds (success: True)
2021-09-26 23:15:12 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:15:12 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.260 seconds (success: True)
2021-09-26 23:15:42 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.103 seconds (success: True)
2021-09-26 23:16:12 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.103 seconds (success: True)
2021-09-26 23:16:42 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.102 seconds (success: True)
2021-09-26 23:17:13 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:17:13 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.080 seconds (success: True)
2021-09-26 23:17:44 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:17:44 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.110 seconds (success: True)
2021-09-26 23:18:14 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.098 seconds (success: True)
2021-09-26 23:18:36 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 23:18:44 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:18:44 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.927 seconds (success: True)
2021-09-26 23:19:14 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.352 seconds (success: True)
2021-09-26 23:19:44 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673164587, name=<EventName.GATEWAY_DOWN: 'GatewayDownEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:19:44 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673174951, name=<EventName.GATEWAY_ALIVE: 'GatewayAliveEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:19:44 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.101 seconds (success: True)
2021-09-26 23:20:15 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:20:15 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.248 seconds (success: True)
2021-09-26 23:20:45 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.099 seconds (success: True)
2021-09-26 23:21:16 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:21:16 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.280 seconds (success: True)
2021-09-26 23:21:46 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673285587, name=<EventName.GATEWAY_DOWN: 'GatewayDownEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:21:46 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673296219, name=<EventName.GATEWAY_ALIVE: 'GatewayAliveEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:21:46 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.108 seconds (success: True)
2021-09-26 23:22:16 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:22:16 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.984 seconds (success: True)
2021-09-26 23:22:46 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.106 seconds (success: True)
2021-09-26 23:23:16 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.098 seconds (success: True)
2021-09-26 23:23:46 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.097 seconds (success: True)
2021-09-26 23:24:17 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:24:17 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.304 seconds (success: True)
2021-09-26 23:24:47 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673486887, name=<EventName.GATEWAY_DOWN: 'GatewayDownEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:24:47 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.113 seconds (success: True)
2021-09-26 23:25:18 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-26 23:25:18 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.253 seconds (success: True)
2021-09-26 23:25:48 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.146 seconds (success: True)
2021-09-26 23:25:50 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673548782, name=<EventName.GATEWAY_DOWN: 'GatewayDownEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550869, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed5214-0a32-0481-5523-a3f2e6d713a8', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550870, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed5214-0a32-0481-5523-a3f2e6d713a8', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550870, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550870, name=<EventName.COMMAND_EXECUTION_STATE_CHANGE: 'CommandExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=<FailureType.PEER_DOWN: 10005>, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed5214-0a32-0481-5523-a3f2e6d713a8', deviceurl=rts://****-****-6362/16730022, device_states=[], old_state=None, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550870, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=[{'deviceurl': 'rts://0402-1619-6362/16730022', 'rank': 0, 'failure_type': 'PEER_DOWN'}], failure_type_code=<FailureType.PEER_DOWN: 10005>, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed5214-0a32-0481-5523-a3f2e6d713a8', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550870, name='GatewaySynchronizationFailedEvent', setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550870, name='GatewaySynchronizationFailedEvent', setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673550871, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:50 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556604, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed687b-0a32-0481-5523-a3f2da98980a', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556604, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed687b-0a32-0481-5523-a3f2da98980a', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556604, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556604, name=<EventName.COMMAND_EXECUTION_STATE_CHANGE: 'CommandExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=<FailureType.PEER_DOWN: 10005>, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed687b-0a32-0481-5523-a3f2da98980a', deviceurl=rts://****-****-6362/16730022, device_states=[], old_state=None, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556604, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=[{'deviceurl': 'rts://0402-1619-6362/16730022', 'rank': 0, 'failure_type': 'PEER_DOWN'}], failure_type_code=<FailureType.PEER_DOWN: 10005>, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed687b-0a32-0481-5523-a3f2da98980a', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556604, name='GatewaySynchronizationFailedEvent', setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556604, name='GatewaySynchronizationFailedEvent', setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=None, metadata={}), owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type='PEER_DOWN', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673556608, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:25:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:00 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673559129, name=<EventName.GATEWAY_ALIVE: 'GatewayAliveEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:00 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673560115, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed7633-0a32-0481-5523-a3f2b5e1a792', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:00 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673560116, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed7633-0a32-0481-5523-a3f2b5e1a792', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-26 23:26:00 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673560116, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:00 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673560117, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed7633-0a32-0481-5523-a3f2b5e1a792', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>)
2021-09-26 23:26:00 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673560118, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:00 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:01 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:26:02 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673561347, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed7633-0a32-0481-5523-a3f2b5e1a792', deviceurl=None, device_states=[], old_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2021-09-26 23:26:02 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:03 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:04 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:05 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:06 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:07 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:26:08 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:09 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:10 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:10 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673570831, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22eda00e-0a32-0481-5523-a3f251ba4a6a', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:10 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673570831, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22eda00e-0a32-0481-5523-a3f251ba4a6a', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.QUEUED_SERVER_SIDE: 'QUEUED_SERVER_SIDE'>)
2021-09-26 23:26:10 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:11 ERROR (MainThread) [custom_components.tahoma] Error fetching device events data: Too many requests, try again later.
2021-09-26 23:26:11 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: False)
2021-09-26 23:26:12 INFO (MainThread) [custom_components.tahoma] Fetching device events data recovered
2021-09-26 23:26:12 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:13 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:14 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.037 seconds (success: True)
2021-09-26 23:26:15 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.046 seconds (success: True)
2021-09-26 23:26:16 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:17 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:18 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:19 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:20 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.044 seconds (success: True)
2021-09-26 23:26:21 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:26:22 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:23 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:26:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:25 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.037 seconds (success: True)
2021-09-26 23:26:25 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673585577, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22edd9a8-0a32-0481-5523-a3f208ea2b7e', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:25 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673585577, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22edd9a8-0a32-0481-5523-a3f208ea2b7e', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.QUEUED_SERVER_SIDE: 'QUEUED_SERVER_SIDE'>)
2021-09-26 23:26:25 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:26 ERROR (MainThread) [custom_components.tahoma] Error fetching device events data: Too many requests, try again later.
2021-09-26 23:26:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: False)
2021-09-26 23:26:27 INFO (MainThread) [custom_components.tahoma] Fetching device events data recovered
2021-09-26 23:26:27 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:28 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:29 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:26:30 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:31 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.060 seconds (success: True)
2021-09-26 23:26:32 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673591646, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ed7633-0a32-0481-5523-a3f2b5e1a792', deviceurl=None, device_states=[], old_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>, new_state=<ExecutionState.COMPLETED: 'COMPLETED'>)
2021-09-26 23:26:32 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673591647, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22eda00e-0a32-0481-5523-a3f251ba4a6a', deviceurl=None, device_states=[], old_state=<ExecutionState.QUEUED_SERVER_SIDE: 'QUEUED_SERVER_SIDE'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-26 23:26:32 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673591647, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:32 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673591649, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22eda00e-0a32-0481-5523-a3f251ba4a6a', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>)
2021-09-26 23:26:32 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673591649, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:26:32 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.038 seconds (success: True)
2021-09-26 23:26:33 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:34 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:35 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:36 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:37 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:26:38 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673597137, name=<EventName.COMMAND_EXECUTION_STATE_CHANGE: 'CommandExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=<FailureType.CANCELLED: 10002>, failure_type='CANCELLED', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22edd9a8-0a32-0481-5523-a3f208ea2b7e', deviceurl=rts://****-****-6362/16730022, device_states=[], old_state=None, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:26:38 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673597138, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=[{'deviceurl': 'rts://0402-1619-6362/16730022', 'rank': 0, 'failure_type': 'CANCELLED'}], failure_type_code=<FailureType.CANCELLED: 10002>, failure_type='CANCELLED', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22edd9a8-0a32-0481-5523-a3f208ea2b7e', deviceurl=None, device_states=[], old_state=<ExecutionState.QUEUED_SERVER_SIDE: 'QUEUED_SERVER_SIDE'>, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:26:38 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.053 seconds (success: True)
2021-09-26 23:26:39 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:26:40 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:41 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:26:42 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:27:01 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673621017, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ee6401-0a32-0481-5523-a3f2fe6d7534', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:27:01 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673621017, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ee6401-0a32-0481-5523-a3f2fe6d7534', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.QUEUED_SERVER_SIDE: 'QUEUED_SERVER_SIDE'>)
2021-09-26 23:27:01 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:02 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:03 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673622282, name=<EventName.GATEWAY_DOWN: 'GatewayDownEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:27:03 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:04 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:05 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:06 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:07 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.040 seconds (success: True)
2021-09-26 23:27:08 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:09 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:10 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:11 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:12 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.030 seconds (success: True)
2021-09-26 23:27:13 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673632516, name=<EventName.GATEWAY_ALIVE: 'GatewayAliveEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:27:13 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673633092, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22eda00e-0a32-0481-5523-a3f251ba4a6a', deviceurl=None, device_states=[], old_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2021-09-26 23:27:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673633093, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22eda00e-0a32-0481-5523-a3f251ba4a6a', deviceurl=None, device_states=[], old_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>, new_state=<ExecutionState.COMPLETED: 'COMPLETED'>)
2021-09-26 23:27:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673633094, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ee6401-0a32-0481-5523-a3f2fe6d7534', deviceurl=None, device_states=[], old_state=<ExecutionState.QUEUED_SERVER_SIDE: 'QUEUED_SERVER_SIDE'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-26 23:27:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673633094, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:27:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673633095, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ee6401-0a32-0481-5523-a3f2fe6d7534', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>)
2021-09-26 23:27:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673633095, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:27:14 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:15 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673634131, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22ee6401-0a32-0481-5523-a3f2fe6d7534', deviceurl=None, device_states=[], old_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2021-09-26 23:27:15 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:16 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:17 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:18 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:19 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:27:20 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:27:21 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:22 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:23 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:27:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:25 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:27 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:28 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.030 seconds (success: True)
2021-09-26 23:27:29 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:30 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:31 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:32 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.030 seconds (success: True)
2021-09-26 23:27:33 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:34 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:35 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:36 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:37 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:38 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:27:39 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:40 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:41 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:42 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:43 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:44 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:45 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:46 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:47 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.031 seconds (success: True)
2021-09-26 23:27:48 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-26 23:27:49 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.032 seconds (success: True)
2021-09-26 23:28:23 INFO (MainThread) [backoff] Backing off execute_commands(...) for 0.7s (pyhoma.exceptions.NotAuthenticatedException: Not authenticated)
2021-09-26 23:28:25 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673705376, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efad9f-0a32-0481-5523-a3f220207f8b', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:25 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673705376, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efad9f-0a32-0481-5523-a3f220207f8b', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-26 23:28:25 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673705376, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:25 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673705378, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efad9f-0a32-0481-5523-a3f220207f8b', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>)
2021-09-26 23:28:25 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673705378, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:25 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:28:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.056 seconds (success: True)
2021-09-26 23:28:27 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673706569, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efad9f-0a32-0481-5523-a3f220207f8b', deviceurl=None, device_states=[], old_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2021-09-26 23:28:27 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:28:28 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:28:29 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673708967, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:29 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-26 23:28:30 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673709631, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:30 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673710128, name=<EventName.COMMAND_EXECUTION_STATE_CHANGE: 'CommandExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=<FailureType.CMDCANCELLED: 106>, failure_type='CMDCANCELLED', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efad9f-0a32-0481-5523-a3f220207f8b', deviceurl=rts://****-****-6362/16730022, device_states=[], old_state=None, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673710129, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=[{'deviceurl': 'rts://0402-1619-6362/16730022', 'rank': 0, 'failure_type': 'CMDCANCELLED'}], failure_type_code=<FailureType.CMDCANCELLED: 106>, failure_type='CMDCANCELLED', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efad9f-0a32-0481-5523-a3f220207f8b', deviceurl=None, device_states=[], old_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673711538, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efc5b1-0a32-0481-5523-a3f23e627795', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673711538, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efc5b1-0a32-0481-5523-a3f23e627795', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673711538, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673711540, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='22efc5b1-0a32-0481-5523-a3f23e627795', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632673711540, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=298, _default=None, repr=<function obfuscate_id at 0x7f9ed412aca0>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-26 23:28:31 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.050 seconds (success: True)
2021-09-26 23:28:32 ERROR (MainThread) [custom_components.tahoma] Error fetching device events data: Too many requests, try again later.
2021-09-26 23:28:32 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: False)
2021-09-26 23:31:43 DEBUG (MainThread) [custom_components.tahoma.coordinator]
2021-09-26 23:31:43 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 300.718 seconds (success: False)
2021-09-26 23:31:44 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.360 seconds (success: False)
iMicknl commented 2 years ago

@p2544 thanks, this is very helpful! It seems our fix is not doing its work, we will provide you with a new version sometime this week.

@tetienne it seems that even RTS devices have a State(name='rts:diy', type=<DataType.BOOLEAN: 6>, value=False)] in the attribute. I don't see this in his states... Perhaps we should just check for rts: prefixes of all devices?

tetienne commented 2 years ago

That's weird because when I see this states=States(_states=[]) it's exactly what my PR look for.

iMicknl commented 2 years ago

That's weird because when I see this states=States(_states=[]) it's exactly what my PR look for.

Exactly.. I wonder why it is still polling every second in his example.

@p2544 are you sure you are running the version we shared with you?

p2544 commented 2 years ago

just delete all the root tahoma and extract again. restart server and home assistant detect somfy overkiz by still cannot login the server refuse too busy image

image

iMicknl commented 2 years ago

@p2544 you need to wait for a while (30 minutes +) until you can try again. Are you sure you are running the version we linked?

p2544 commented 2 years ago

@p2544 you need to wait for a while (30 minutes +) until you can try again. Are you sure you are running the version we linked?

yes it work now, but need to see will it disappear again.

iMicknl commented 2 years ago

If it happens again, please share your full log. However, it should just pull your data every 30 minutes now.

p2544 commented 2 years ago

yes it happen again. here is the log

Logger: libav.tcp
Source: components/stream/worker.py:321
First occurred: September 28, 2021, 11:45:26 PM (151 occurrences)
Last logged: 7:20:38 AM

Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable

2021-09-28 23:44:33 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration tuya_v2 which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-28 23:44:33 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration tahoma which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-28 23:44:33 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-28 23:44:33 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration connector which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-28 23:45:26 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:45:37 DEBUG (MainThread) [custom_components.tahoma.config_flow] DHCP discovery detected gateway ****-****-6362
2021-09-28 23:45:39 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:46:02 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:46:35 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:47:19 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:48:12 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:49:15 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:50:28 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:51:51 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:53:24 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:55:07 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:57:00 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-28 23:59:03 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:01:16 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:03:39 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:06:12 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:08:55 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:11:49 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:14:52 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:18:05 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:21:28 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:25:01 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:28:44 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:32:37 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:36:40 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:40:53 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:45:16 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:49:49 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:54:32 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 00:59:25 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:04:29 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:09:42 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:15:05 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:20:38 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:26:21 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:32:14 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:38:17 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:44:30 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:50:53 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 01:57:26 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:04:09 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:11:02 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:18:06 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:25:19 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:32:42 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:40:15 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:47:58 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 02:55:51 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 03:03:54 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 03:12:07 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 03:20:30 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 03:29:03 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 03:37:46 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 03:46:39 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 03:55:43 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 04:04:56 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 04:14:19 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 04:23:52 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 04:33:35 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 04:43:28 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 04:53:31 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 05:03:44 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 05:14:07 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 05:24:40 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 05:35:23 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 05:46:16 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 05:57:19 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 06:08:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 06:19:56 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 06:31:29 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 06:43:12 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 06:55:05 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 07:07:08 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 07:19:21 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 07:31:44 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 07:44:17 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 07:57:00 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 08:09:53 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 08:22:56 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 08:36:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 08:49:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 09:03:06 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 09:16:49 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 09:30:42 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 09:44:45 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 09:58:58 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 10:13:21 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 10:27:54 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 10:42:37 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 10:57:30 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 11:12:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 11:27:46 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 11:43:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 11:58:43 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 12:14:26 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 12:30:19 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 12:46:22 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 13:02:35 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 13:18:58 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 13:35:31 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 13:52:14 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 14:09:07 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 14:26:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 14:43:23 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 15:00:47 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 15:18:20 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 15:36:03 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 15:53:56 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 16:11:59 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 16:30:12 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 16:48:35 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 17:07:08 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 17:25:51 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 17:44:44 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 18:03:47 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 18:23:00 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 18:42:23 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 19:01:57 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 19:21:40 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 19:41:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 20:01:36 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 20:21:49 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 20:42:12 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 21:02:45 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 21:23:28 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 21:44:21 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 22:05:24 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 22:26:37 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 22:48:00 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 23:09:33 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 23:31:17 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-29 23:53:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 00:15:13 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 00:37:26 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 00:59:49 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 01:22:22 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 01:45:05 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 02:07:58 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 02:31:01 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 02:54:14 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 03:17:37 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 03:41:10 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 04:04:54 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 04:28:47 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 04:52:50 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 05:17:03 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 05:41:26 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 06:05:59 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 06:30:42 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 06:55:35 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
2021-09-30 07:20:38 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.139:554?timeout=5000000 failed: Host is unreachable
iMicknl commented 2 years ago

@p2544 I have no clue why your log only has one line related to the TaHoma integration. This means that it hasn't been set up yet. Did you take this changelog after rebooting your installation?

By the way, the libav.tcp line that is flooding your log is not related to our integration. It seems that you have an IP camera on 192.168.1.139 that is not functional anymore.

p2544 commented 2 years ago

this is the log from another server in the same place

2021-09-30 09:24:06 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-30 09:24:06 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration tahoma which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-30 09:24:06 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration tuya_v2 which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-30 09:24:06 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration connector which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-09-30 09:24:50 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Host is unreachable
2021-09-30 09:25:02 DEBUG (MainThread) [custom_components.tahoma.config_flow] DHCP discovery detected gateway ****-****-6362
2021-09-30 09:25:58 ERROR (stream_worker) [libav.h264] error while decoding MB 43 13, bytestream -9
2021-09-30 09:26:40 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Operation timed out
2021-09-30 09:27:26 ERROR (stream_worker) [libav.rtsp] Undefined type (31)
2021-09-30 09:27:30 ERROR (stream_worker) [libav.h264] missing picture in access unit with size 1452
2021-09-30 09:27:30 ERROR (stream_worker) [libav.h264] no frame!
2021-09-30 09:29:59 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 09:31:22 ERROR (stream_worker) [libav.h264] error while decoding MB 32 40, bytestream -21
2021-09-30 09:31:23 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 09:34:49 ERROR (stream_worker) [libav.h264] error while decoding MB 75 36, bytestream -7
2021-09-30 09:34:50 ERROR (stream_worker) [libav.h264] missing picture in access unit with size 1452
2021-09-30 09:34:50 ERROR (stream_worker) [libav.h264] no frame!
2021-09-30 09:36:43 ERROR (stream_worker) [libav.rtsp] Undefined type (31)
2021-09-30 09:36:43 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 09:36:57 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 09:37:00 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 09:39:16 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 09:39:23 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 09:39:23 ERROR (stream_worker) [libav.NULL] SEI type 235 size 1464 truncated at 112
2021-09-30 09:42:10 ERROR (stream_worker) [libav.h264] error while decoding MB 35 11, bytestream -5
2021-09-30 09:47:14 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Operation timed out
2021-09-30 09:50:03 ERROR (stream_worker) [libav.h264] cabac decode of qscale diff failed at 111 14
2021-09-30 09:50:03 ERROR (stream_worker) [libav.h264] error while decoding MB 111 14, bytestream 17027
2021-09-30 09:53:08 ERROR (stream_worker) [libav.h264] left block unavailable for requested intra mode
2021-09-30 09:53:08 ERROR (stream_worker) [libav.h264] error while decoding MB 0 30, bytestream 53
2021-09-30 09:53:08 ERROR (stream_worker) [libav.h264] error while decoding MB 36 54, bytestream -17
2021-09-30 09:56:13 ERROR (stream_worker) [libav.NULL] non-existing PPS 1 referenced
2021-09-30 10:10:53 ERROR (stream_worker) [libav.h264] left block unavailable for requested intra4x4 mode -1
2021-09-30 10:10:53 ERROR (stream_worker) [libav.h264] error while decoding MB 0 19, bytestream 2442
2021-09-30 10:14:38 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Operation timed out
2021-09-30 10:22:55 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 10:23:22 ERROR (stream_worker) [libav.rtsp] Undefined type (31)
2021-09-30 10:23:23 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 10:27:41 ERROR (stream_worker) [libav.h264] error while decoding MB 65 47, bytestream -23
2021-09-30 10:27:42 ERROR (stream_worker) [libav.h264] illegal aspect ratio
2021-09-30 10:27:42 ERROR (stream_worker) [libav.h264] illegal aspect ratio
2021-09-30 10:27:42 ERROR (stream_worker) [libav.h264] illegal aspect ratio
(repeated 2 more times)
2021-09-30 10:32:16 ERROR (stream_worker) [libav.h264] error while decoding MB 103 29, bytestream -16
2021-09-30 10:37:01 ERROR (stream_worker) [libav.h264] error while decoding MB 44 43, bytestream -9
2021-09-30 10:37:10 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 10:37:28 ERROR (stream_worker) [libav.NULL] missing picture in access unit with size 5807
2021-09-30 10:42:48 ERROR (stream_worker) [libav.NULL] sps_id 4 out of range
2021-09-30 10:42:48 ERROR (stream_worker) [libav.NULL] missing picture in access unit with size 1451
2021-09-30 11:09:23 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Host is unreachable
2021-09-30 12:01:21 ERROR (stream_worker) [libav.rtsp] Undefined type (30)
2021-09-30 12:01:21 ERROR (stream_worker) [libav.h264] error while decoding MB 104 63, bytestream -15
2021-09-30 12:09:14 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 12:32:06 ERROR (stream_worker) [libav.h264] error while decoding MB 58 63, bytestream -7
2021-09-30 12:48:07 ERROR (stream_worker) [libav.h264] error while decoding MB 65 41, bytestream -6
2021-09-30 13:13:12 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Operation timed out
2021-09-30 13:22:31 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 13:22:31 ERROR (stream_worker) [libav.NULL] pps_id 313 out of range
2021-09-30 13:22:37 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 13:31:27 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 14:19:09 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 14:29:17 ERROR (stream_worker) [libav.h264] error while decoding MB 83 23, bytestream -7
2021-09-30 14:49:27 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Operation timed out
2021-09-30 14:59:46 ERROR (stream_worker) [libav.rtsp] Undefined type (31)
2021-09-30 14:59:46 ERROR (stream_worker) [libav.h264] left block unavailable for requested intra4x4 mode -1
2021-09-30 14:59:46 ERROR (stream_worker) [libav.h264] error while decoding MB 0 15, bytestream 465
2021-09-30 14:59:53 ERROR (stream_worker) [libav.rtsp] Undefined type (30)
2021-09-30 14:59:54 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 15:10:34 ERROR (stream_worker) [libav.h264] cabac decode of qscale diff failed at 14 21
2021-09-30 15:10:34 ERROR (stream_worker) [libav.h264] error while decoding MB 14 21, bytestream 25705
2021-09-30 15:10:38 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-09-30 15:32:28 ERROR (stream_worker) [libav.h264] error while decoding MB 53 27, bytestream -37
2021-09-30 15:43:32 ERROR (stream_worker) [libav.rtsp] Missed some packets, discarding frame
2021-09-30 15:54:49 ERROR (stream_worker) [libav.rtsp] Undefined type (30)
2021-09-30 15:54:52 ERROR (stream_worker) [libav.rtsp] nal size exceeds length: 29377 1445
2021-09-30 15:54:52 ERROR (stream_worker) [libav.h264] left block unavailable for requested intra4x4 mode -1
2021-09-30 15:54:52 ERROR (stream_worker) [libav.h264] error while decoding MB 0 46, bytestream 915
2021-09-30 15:54:52 ERROR (stream_worker) [libav.h264] non-existing PPS 1 referenced
2021-09-30 15:54:52 ERROR (stream_worker) [libav.h264] A non-intra slice in an IDR NAL unit.
2021-09-30 15:54:52 ERROR (stream_worker) [libav.h264] decode_slice_header error
2021-09-30 15:54:52 ERROR (stream_worker) [libav.h264] no frame!
2021-09-30 15:54:59 ERROR (stream_worker) [libav.rtsp] Missed some packets, discarding frame
2021-09-30 16:21:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:21:26 DEBUG (MainThread) [custom_components.tahoma] Added device (Device(attributes=States(_states=[State(name='rts:diy', type=<DataType.BOOLEAN: 6>, value=False)]), available=True, enabled=True, label='หน้าต่างม้วนแม่บ้าน', deviceurl=rts://****-****-6362/16730022, controllable_name='rts:RollerShutterRTSComponent', definition=Definition(commands=CommandDefinitions(_commands=[CommandDefinition(command_name='close', nparams=1), CommandDefinition(command_name='down', nparams=1), CommandDefinition(command_name='identify', nparams=0), CommandDefinition(command_name='my', nparams=1), CommandDefinition(command_name='open', nparams=1), CommandDefinition(command_name='rest', nparams=1), CommandDefinition(command_name='stop', nparams=1), CommandDefinition(command_name='test', nparams=0), CommandDefinition(command_name='up', nparams=1), CommandDefinition(command_name='openConfiguration', nparams=1)]), states=[], widget_name='UpDownRollerShutter', ui_class='RollerShutter', qualified_name='rts:RollerShutterRTSComponent'), data_properties=None, widget='UpDownRollerShutter', ui_class='RollerShutter', states=States(_states=[]), type=<ProductType.ACTUATOR: 1>, placeoid='6133b4a0-f514-4553-b635-d1b7beb7e7b2'))
2021-09-30 16:21:26 DEBUG (MainThread) [custom_components.tahoma] Added device (Device(attributes=States(_states=[State(name='rts:diy', type=<DataType.BOOLEAN: 6>, value=False)]), available=True, enabled=True, label='ประตูม้วนครัว', deviceurl=rts://****-****-6362/16749917, controllable_name='rts:RollerShutterRTSComponent', definition=Definition(commands=CommandDefinitions(_commands=[CommandDefinition(command_name='close', nparams=1), CommandDefinition(command_name='down', nparams=1), CommandDefinition(command_name='identify', nparams=0), CommandDefinition(command_name='my', nparams=1), CommandDefinition(command_name='open', nparams=1), CommandDefinition(command_name='rest', nparams=1), CommandDefinition(command_name='stop', nparams=1), CommandDefinition(command_name='test', nparams=0), CommandDefinition(command_name='up', nparams=1), CommandDefinition(command_name='openConfiguration', nparams=1)]), states=[], widget_name='UpDownRollerShutter', ui_class='RollerShutter', qualified_name='rts:RollerShutterRTSComponent'), data_properties=None, widget='UpDownRollerShutter', ui_class='RollerShutter', states=States(_states=[]), type=<ProductType.ACTUATOR: 1>, placeoid='6133b4a0-f514-4553-b635-d1b7beb7e7b2'))
2021-09-30 16:21:26 DEBUG (MainThread) [custom_components.tahoma] Added gateway (Gateway(partners=[Partner(activated=True, name='Somfy Thailand', id=somfy-thailand, status='OWNER')], functions='INTERNET_AUTHORIZATION,SCENARIO_DOWNLOAD,SCENARIO_AUTO_LAUNCHING,SCENARIO_TELECO_LAUNCHING,INTERNET_UPLOAD,INTERNET_UPDATE,TRIGGERS_SENSORS', sub_type=<GatewaySubType.TAHOMA_BASIC: 1>, id=****-****-6362, gateway_id=NOTHING, alive=True, mode='ACTIVE', placeoid='6133b4a0-f514-4553-b635-d1b7beb7e7b2', time_reliable=True, connectivity=Connectivity(status='OK', protocol_version='2021.2.4'), up_to_date=True, update_status=<UpdateBoxStatus.UP_TO_DATE: 'UP_TO_DATE'>, sync_in_progress=False, type=<GatewayType.CONNEXOON_RTS: 53>))
2021-09-30 16:21:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.103 seconds (success: True)
2021-09-30 16:22:09 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993729130, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602da69-0a32-0481-5523-a3f2502a9805', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:09 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993729130, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602da69-0a32-0481-5523-a3f2502a9805', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-30 16:22:09 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993729130, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=593, _default=None, repr=<function obfuscate_id at 0x7f8e63300820>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:09 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993729132, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602da69-0a32-0481-5523-a3f2502a9805', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>)
2021-09-30 16:22:09 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993729132, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=593, _default=None, repr=<function obfuscate_id at 0x7f8e63300820>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:09 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.037 seconds (success: True)
2021-09-30 16:22:10 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:11 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993730343, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602da69-0a32-0481-5523-a3f2502a9805', deviceurl=None, device_states=[], old_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2021-09-30 16:22:11 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:12 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993731912, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=593, _default=None, repr=<function obfuscate_id at 0x7f8e63300820>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:12 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:13 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993732568, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=593, _default=None, repr=<function obfuscate_id at 0x7f8e63300820>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:13 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.037 seconds (success: True)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993733087, name=<EventName.COMMAND_EXECUTION_STATE_CHANGE: 'CommandExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=None, sub_type=None, time_to_next_state=None, failed_commands=None, failure_type_code=<FailureType.CMDCANCELLED: 106>, failure_type='CMDCANCELLED', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602da69-0a32-0481-5523-a3f2502a9805', deviceurl=rts://****-****-6362/16730022, device_states=[], old_state=None, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993733087, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=[{'deviceurl': 'rts://0402-1619-6362/16730022', 'rank': 0, 'failure_type': 'CMDCANCELLED'}], failure_type_code=<FailureType.CMDCANCELLED: 106>, failure_type='CMDCANCELLED', condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602da69-0a32-0481-5523-a3f2502a9805', deviceurl=None, device_states=[], old_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>, new_state=<ExecutionState.FAILED: 'FAILED'>)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993734115, name=<EventName.EXECUTION_REGISTERED: 'ExecutionRegisteredEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=None, type=1, sub_type=1, time_to_next_state=None, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label='Home Assistant', metadata='', camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602ede2-0a32-0481-5523-a3f23fb47e45', deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993734115, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602ede2-0a32-0481-5523-a3f23fb47e45', deviceurl=None, device_states=[], old_state=<ExecutionState.INITIALIZED: 'INITIALIZED'>, new_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993734115, name=<EventName.GATEWAY_SYNCHRONIZATION_STARTED: 'GatewaySynchronizationStartedEvent'>, setupoid=_CountingAttr(counter=593, _default=None, repr=<function obfuscate_id at 0x7f8e63300820>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993734117, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602ede2-0a32-0481-5523-a3f23fb47e45', deviceurl=None, device_states=[], old_state=<ExecutionState.NOT_TRANSMITTED: 'NOT_TRANSMITTED'>, new_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993734117, name=<EventName.GATEWAY_SYNCHRONIZATION_ENDED: 'GatewaySynchronizationEndedEvent'>, setupoid=_CountingAttr(counter=593, _default=None, repr=<function obfuscate_id at 0x7f8e63300820>, eq=True, order=True, hash=None, init=True, on_setattr=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, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=****-****-6362, exec_id=None, deviceurl=None, device_states=[], old_state=None, new_state=None)
2021-09-30 16:22:14 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:15 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:16 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993735333, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=0, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602ede2-0a32-0481-5523-a3f23fb47e45', deviceurl=None, device_states=[], old_state=<ExecutionState.TRANSMITTED: 'TRANSMITTED'>, new_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>)
2021-09-30 16:22:16 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:17 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:18 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:19 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:20 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:21 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:22 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:23 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:25 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:27 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:28 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:29 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.041 seconds (success: True)
2021-09-30 16:22:30 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.062 seconds (success: True)
2021-09-30 16:22:31 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:32 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.033 seconds (success: True)
2021-09-30 16:22:33 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.049 seconds (success: True)
2021-09-30 16:22:34 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:35 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:36 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:37 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:38 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:39 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:40 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.036 seconds (success: True)
2021-09-30 16:22:41 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:42 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:43 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.035 seconds (success: True)
2021-09-30 16:22:44 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.034 seconds (success: True)
2021-09-30 16:22:45 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.038 seconds (success: True)
2021-09-30 16:22:46 DEBUG (MainThread) [custom_components.tahoma.coordinator] Event(timestamp=1632993765622, name=<EventName.EXECUTION_STATE_CHANGED: 'ExecutionStateChangedEvent'>, setupoid=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, owner_key=fee37cf****-1d****-49fc-8d****-af71dfe20c4d, type=1, sub_type=1, time_to_next_state=-1, failed_commands=None, failure_type_code=None, failure_type=None, condition_groupoid=None, placeoid=None, label=None, metadata=None, camera_id=None, deleted_raw_devices_count=None, protocol_type=None, gateway_id=None, exec_id='3602ede2-0a32-0481-5523-a3f23fb47e45', deviceurl=None, device_states=[], old_state=<ExecutionState.IN_PROGRESS: 'IN_PROGRESS'>, new_state=<ExecutionState.COMPLETED: 'COMPLETED'>)
2021-09-30 16:22:46 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.043 seconds (success: True)
2021-09-30 16:23:17 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:23:17 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.074 seconds (success: True)
2021-09-30 16:23:47 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:23:48 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.028 seconds (success: True)
2021-09-30 16:24:19 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:24:19 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.472 seconds (success: True)
2021-09-30 16:24:49 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.108 seconds (success: True)
2021-09-30 16:25:19 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.108 seconds (success: True)
2021-09-30 16:25:49 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.111 seconds (success: True)
2021-09-30 16:26:19 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.103 seconds (success: True)
2021-09-30 16:26:50 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:26:50 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.410 seconds (success: True)
2021-09-30 16:27:20 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.107 seconds (success: True)
2021-09-30 16:27:50 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.104 seconds (success: True)
2021-09-30 16:28:20 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.102 seconds (success: True)
2021-09-30 16:28:50 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.101 seconds (success: True)
2021-09-30 16:29:21 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:29:21 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.357 seconds (success: True)
2021-09-30 16:29:51 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.122 seconds (success: True)
2021-09-30 16:30:21 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.108 seconds (success: True)
2021-09-30 16:30:52 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:30:52 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.089 seconds (success: True)
2021-09-30 16:31:23 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:31:23 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.109 seconds (success: True)
2021-09-30 16:31:54 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:31:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.347 seconds (success: True)
2021-09-30 16:32:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.112 seconds (success: True)
2021-09-30 16:32:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.106 seconds (success: True)
2021-09-30 16:33:24 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices
2021-09-30 16:33:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.998 seconds (success: True)
2021-09-30 16:33:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.121 seconds (success: True)
2021-09-30 16:34:24 ERROR (MainThread) [custom_components.tahoma] Error fetching device events data: Too many requests, try again later.
2021-09-30 16:34:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.420 seconds (success: False)
2021-09-30 16:34:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 16:35:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 16:35:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 16:36:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 16:36:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.450 seconds (success: False)
2021-09-30 16:37:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 16:37:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 16:38:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.150 seconds (success: False)
2021-09-30 16:38:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 16:39:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.136 seconds (success: False)
2021-09-30 16:39:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.146 seconds (success: False)
2021-09-30 16:40:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 16:40:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 16:41:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.144 seconds (success: False)
2021-09-30 16:41:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 16:42:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.486 seconds (success: False)
2021-09-30 16:42:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 16:43:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 16:43:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.144 seconds (success: False)
2021-09-30 16:44:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 16:44:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.427 seconds (success: False)
2021-09-30 16:45:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.134 seconds (success: False)
2021-09-30 16:45:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 16:46:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 16:46:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.133 seconds (success: False)
2021-09-30 16:47:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 16:47:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.496 seconds (success: False)
2021-09-30 16:48:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.149 seconds (success: False)
2021-09-30 16:48:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.132 seconds (success: False)
2021-09-30 16:49:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 16:49:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.136 seconds (success: False)
2021-09-30 16:50:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.410 seconds (success: False)
2021-09-30 16:50:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 16:51:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 16:51:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 16:52:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.136 seconds (success: False)
2021-09-30 16:52:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.147 seconds (success: False)
2021-09-30 16:53:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.447 seconds (success: False)
2021-09-30 16:53:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.171 seconds (success: False)
2021-09-30 16:54:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.155 seconds (success: False)
2021-09-30 16:54:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 16:55:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.153 seconds (success: False)
2021-09-30 16:55:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.467 seconds (success: False)
2021-09-30 16:56:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 16:56:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 16:57:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 16:57:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.158 seconds (success: False)
2021-09-30 16:58:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.147 seconds (success: False)
2021-09-30 16:58:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.478 seconds (success: False)
2021-09-30 16:59:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.150 seconds (success: False)
2021-09-30 16:59:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 17:00:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 17:00:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:01:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.417 seconds (success: False)
2021-09-30 17:01:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:02:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:02:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.153 seconds (success: False)
2021-09-30 17:03:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:03:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.134 seconds (success: False)
2021-09-30 17:04:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.427 seconds (success: False)
2021-09-30 17:04:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:05:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 17:05:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 17:06:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 17:06:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.464 seconds (success: False)
2021-09-30 17:07:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.147 seconds (success: False)
2021-09-30 17:07:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 17:08:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:08:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 17:09:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.148 seconds (success: False)
2021-09-30 17:09:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.465 seconds (success: False)
2021-09-30 17:10:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.131 seconds (success: False)
2021-09-30 17:10:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 17:11:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 17:11:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:12:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.450 seconds (success: False)
2021-09-30 17:12:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.134 seconds (success: False)
2021-09-30 17:13:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:13:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 17:14:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 17:14:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.143 seconds (success: False)
2021-09-30 17:15:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.434 seconds (success: False)
2021-09-30 17:15:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 17:16:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.161 seconds (success: False)
2021-09-30 17:16:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.144 seconds (success: False)
2021-09-30 17:17:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.415 seconds (success: False)
2021-09-30 17:17:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.423 seconds (success: False)
2021-09-30 17:18:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.143 seconds (success: False)
2021-09-30 17:18:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.136 seconds (success: False)
2021-09-30 17:19:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:19:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 17:20:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.360 seconds (success: False)
2021-09-30 17:20:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.433 seconds (success: False)
2021-09-30 17:21:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.155 seconds (success: False)
2021-09-30 17:21:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:22:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.157 seconds (success: False)
2021-09-30 17:22:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.166 seconds (success: False)
2021-09-30 17:23:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.443 seconds (success: False)
2021-09-30 17:23:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 17:24:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:24:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 17:25:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 17:25:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 17:26:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.414 seconds (success: False)
2021-09-30 17:26:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 17:27:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.158 seconds (success: False)
2021-09-30 17:27:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 17:28:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.131 seconds (success: False)
2021-09-30 17:28:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.512 seconds (success: False)
2021-09-30 17:29:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.133 seconds (success: False)
2021-09-30 17:29:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 17:30:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 17:30:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:31:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.131 seconds (success: False)
2021-09-30 17:31:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.426 seconds (success: False)
2021-09-30 17:32:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:32:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 17:33:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 17:33:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:34:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.423 seconds (success: False)
2021-09-30 17:34:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 17:35:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.143 seconds (success: False)
2021-09-30 17:35:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.144 seconds (success: False)
2021-09-30 17:36:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.163 seconds (success: False)
2021-09-30 17:36:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 17:37:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.456 seconds (success: False)
2021-09-30 17:37:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 17:38:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.134 seconds (success: False)
2021-09-30 17:38:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.134 seconds (success: False)
2021-09-30 17:39:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 17:39:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.472 seconds (success: False)
2021-09-30 17:40:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.160 seconds (success: False)
2021-09-30 17:40:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.160 seconds (success: False)
2021-09-30 17:41:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.169 seconds (success: False)
2021-09-30 17:41:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 17:42:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.144 seconds (success: False)
2021-09-30 17:42:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.496 seconds (success: False)
2021-09-30 17:43:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.146 seconds (success: False)
2021-09-30 17:43:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.938 seconds (success: False)
2021-09-30 17:44:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.151 seconds (success: False)
2021-09-30 17:44:54 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.146 seconds (success: False)
2021-09-30 17:45:24 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.436 seconds (success: False)
2021-09-30 17:45:34 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Operation timed out
2021-09-30 17:45:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 2.057 seconds (success: False)
2021-09-30 17:46:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.697 seconds (success: False)
2021-09-30 17:46:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 17:47:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 17:47:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.478 seconds (success: False)
2021-09-30 17:48:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 17:48:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.136 seconds (success: False)
2021-09-30 17:49:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 17:49:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:50:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.490 seconds (success: False)
2021-09-30 17:50:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:51:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.161 seconds (success: False)
2021-09-30 17:51:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 17:52:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 17:52:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:53:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.407 seconds (success: False)
2021-09-30 17:53:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.147 seconds (success: False)
2021-09-30 17:54:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 17:54:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.138 seconds (success: False)
2021-09-30 17:55:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.146 seconds (success: False)
2021-09-30 17:55:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.410 seconds (success: False)
2021-09-30 17:56:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.135 seconds (success: False)
2021-09-30 17:56:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 17:57:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.216 seconds (success: False)
2021-09-30 17:57:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 17:58:19 ERROR (stream_worker) [libav.tcp] Connection to tcp://192.168.1.52:554?timeout=5000000 failed: Operation timed out
2021-09-30 17:58:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.143 seconds (success: False)
2021-09-30 17:58:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.155 seconds (success: False)
2021-09-30 17:59:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.158 seconds (success: False)
2021-09-30 17:59:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.162 seconds (success: False)
2021-09-30 18:00:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.139 seconds (success: False)
2021-09-30 18:00:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 18:01:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.476 seconds (success: False)
2021-09-30 18:01:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 18:02:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 18:02:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 18:03:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 18:03:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.168 seconds (success: False)
2021-09-30 18:04:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.538 seconds (success: False)
2021-09-30 18:04:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.148 seconds (success: False)
2021-09-30 18:05:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 18:05:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 18:06:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.141 seconds (success: False)
2021-09-30 18:06:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.523 seconds (success: False)
2021-09-30 18:07:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.198 seconds (success: False)
2021-09-30 18:07:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.133 seconds (success: False)
2021-09-30 18:08:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.133 seconds (success: False)
2021-09-30 18:08:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.154 seconds (success: False)
2021-09-30 18:09:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.145 seconds (success: False)
2021-09-30 18:09:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.436 seconds (success: False)
2021-09-30 18:10:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
2021-09-30 18:10:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.142 seconds (success: False)
2021-09-30 18:11:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.143 seconds (success: False)
2021-09-30 18:11:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.140 seconds (success: False)
2021-09-30 18:12:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.417 seconds (success: False)
2021-09-30 18:12:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.149 seconds (success: False)
2021-09-30 18:13:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.161 seconds (success: False)
2021-09-30 18:13:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.457 seconds (success: False)
2021-09-30 18:14:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.150 seconds (success: False)
2021-09-30 18:14:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.185 seconds (success: False)
2021-09-30 18:15:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.491 seconds (success: False)
2021-09-30 18:15:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.144 seconds (success: False)
2021-09-30 18:16:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.143 seconds (success: False)
2021-09-30 18:16:56 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.154 seconds (success: False)
2021-09-30 18:17:26 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.137 seconds (success: False)
iMicknl commented 2 years ago

Thanks! And to be sure, again, are you running the version we shared with you? (https://github.com/iMicknl/ha-tahoma/archive/refs/heads/feature/remove-custom-interval.zip)

And why do you run multiple servers with Home Assistant? Could it be that you are constantly polling from multiple installations as well?

p2544 commented 2 years ago

I using the files you send to me at the beginning, and the reason I have 2 servers at the same place because another one is just for testing, however this time I will try to shut 1 server off then wait to see if it still have problem I will reinstall fresh Home assistant and only install this tahoma integrate before anything and let see what will happen again.

image

iMicknl commented 2 years ago

If you are using that version, than it seems that our fix is not working. It should use a different update interval and I don't see this in your log.

Would you be able to work with me via Discord (iMick #1903) so we can speed up the development? Easiest would be if you could temporary change your password and send your credentials, so I can do some live debugging on my machine.

sichip commented 2 years ago

I was experiencing the exact same issue as p2544 above, using Somfy (Oceania), and the standard release from HACS. This happened after successfully using my blinds at least once. I have a Somfy Connexoon RTS and I am in Australia.

After uninstalling, waiting a while, reinstalling + reconfiguring, then changing the interval from 30 to 300, I got it to not fail setup, but only after a couple tries. After successfully reconfiguring, I moved some blinds up and down, but at one point, my controls greyed out. I assume this was at the point on line 104 of my attached log where it got a Too Many Requests error.

While my setup is stable for now, I thought I'd contribute my log file to try assist with this issue, as I'm not sure if it might happen again to me. overkiz_oceania.log

Let me know if there's anything else I can do on my end to help.

sichip commented 2 years ago

Spoke too soon, controls greyed out and not returning. This occurred when I wasn't even using HA actively. More log:

2021-10-02 20:42:02 DEBUG (MainThread) [custom_components.hacs] Nothing in the queue 2021-10-02 20:44:20 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices 2021-10-02 20:44:20 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.691 seconds (success: True) 2021-10-02 20:49:21 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices 2021-10-02 20:49:21 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.681 seconds (success: True) 2021-10-02 20:52:02 DEBUG (MainThread) [custom_components.hacs] Nothing in the queue 2021-10-02 20:54:22 DEBUG (MainThread) [custom_components.tahoma.coordinator] Fetching all devices and state via /setup/devices 2021-10-02 20:54:22 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 1.669 seconds (success: True) 2021-10-02 20:59:22 ERROR (MainThread) [custom_components.tahoma] Error fetching device events data: Too many requests, try again later. 2021-10-02 20:59:22 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.723 seconds (success: False) 2021-10-02 21:02:02 DEBUG (MainThread) [custom_components.hacs] Nothing in the queue 2021-10-02 21:04:22 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.452 seconds (success: False) 2021-10-02 21:09:22 DEBUG (MainThread) [custom_components.tahoma] Finished fetching device events data in 0.722 seconds (success: False)

iMicknl commented 2 years ago

@sichip @p2544 based on the credentials of @p2544 I created a new version.

Could you give https://github.com/iMicknl/ha-tahoma/archive/refs/heads/feature/remove-custom-interval.zip a try? Extract this file and place custom_components/tahoma in your custom_components folder. Please make sure you are not using previous version, which has the same name.

This should update the polling interval to 1 hour and will remove the every second polling on executions. I assume this will fix your issues mostly.

sichip commented 2 years ago

The zip link above didn't work, so I got the latest from master after the latest commit, and it all appears stable, even after an hour with many blind movements. Thanks for figuring this one out!!

p2544 commented 2 years ago

@sichip @p2544 based on the credentials of @p2544 I created a new version.

Could you give https://github.com/iMicknl/ha-tahoma/archive/refs/heads/feature/remove-custom-interval.zip a try? Extract this file and place custom_components/tahoma in your custom_components folder. Please make sure you are not using previous version, which has the same name.

This should update the polling interval to 1 hour and will remove the every second polling on executions. I assume this will fix your issues mostly.

this link is not found

sichip commented 2 years ago

@sichip @p2544 based on the credentials of @p2544 I created a new version. Could you give https://github.com/iMicknl/ha-tahoma/archive/refs/heads/feature/remove-custom-interval.zip a try? Extract this file and place custom_components/tahoma in your custom_components folder. Please make sure you are not using previous version, which has the same name. This should update the polling interval to 1 hour and will remove the every second polling on executions. I assume this will fix your issues mostly.

this link is not found

in HACS, select the reinstall option on the integration, enable beta versions, and select master to install. this should pull in the latest update with the stateless RTS device fix :)

bedo2405 commented 2 years ago

Oh, just what I was looking for, thanks so much! I'll give it a go and see what happens.

p2544 commented 2 years ago

already install hac with master version, the integration still got error image

bedo2405 commented 2 years ago

Oh, just what I was looking for, thanks so much! I'll give it a go and see what happens.

It's been a few hours now and all is good. I did have too disable it for an hour after updating just to let the error clear, and now it's working fine. Thanks again

p2544 commented 2 years ago

now it seem to be connected but the button still disable image

image

iMicknl commented 2 years ago

@p2544 could you share your log here please? (with debug mode on).

However, @bedo2405 is right. Fully disable your integration and wait a few hours. Now you should be able to login (with our new version).

p2544 commented 2 years ago

@p2544 could you share your log here please? (with debug mode on).

However, @bedo2405 is right. Fully disable your integration and wait a few hours. Now you should be able to login (with our new version).

I will disable the integration too same as @bedo2405 and will wait to see what happen, how already setup log and will see more results soon.

p2544 commented 2 years ago

@p2544 could you share your log here please? (with debug mode on).

However, @bedo2405 is right. Fully disable your integration and wait a few hours. Now you should be able to login (with our new version).

image

this is my latest log and status.

2021-10-05 21:19:30 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration webrtc which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration localtuya which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_2) [homeassistant.loader] We found a custom integration tahoma which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_4) [homeassistant.loader] We found a custom integration connector which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration smartir which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration tasmota_irhvac which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_3) [homeassistant.loader] We found a custom integration xiaomi_miio_fan which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_1) [homeassistant.loader] We found a custom integration spotcast which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_0) [homeassistant.loader] We found a custom integration ezviz_cloud which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:19:30 WARNING (SyncWorker_5) [homeassistant.loader] We found a custom integration hacs which has not been tested by Home Assistant. This component might cause stability problems, be sure to disable it if you experience issues with Home Assistant
2021-10-05 21:20:26 ERROR (stream_worker) [libav.rtsp] Undefined type (30)
2021-10-05 22:43:31 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 22:45:02 ERROR (stream_worker) [libav.rtsp] Undefined type (31)
2021-10-05 22:45:02 ERROR (stream_worker) [libav.rtsp] nal size exceeds length: 35179 1279
2021-10-05 22:45:02 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:05:27 ERROR (stream_worker) [libav.NULL] non-existing PPS 6 referenced
2021-10-05 23:05:56 ERROR (stream_worker) [libav.rtsp] nal size exceeds length: 18714 121
2021-10-05 23:06:22 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:06:22 ERROR (stream_worker) [libav.NULL] sps_id 1 out of range
2021-10-05 23:06:46 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:07:07 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:12:29 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:13:46 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:14:00 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:45:19 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-05 23:45:19 ERROR (stream_worker) [libav.NULL] missing picture in access unit with size 228
2021-10-06 00:00:57 ERROR (stream_worker) [libav.rtsp] Undefined type (31)
2021-10-06 00:01:43 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-06 00:02:02 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-06 00:02:04 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-06 00:09:10 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-06 00:13:55 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-06 00:13:57 ERROR (stream_worker) [libav.NULL] missing picture in access unit with size 928
2021-10-06 00:14:40 ERROR (stream_worker) [libav.rtsp] Error parsing AU headers
2021-10-06 00:20:25 DEBUG (MainThread) [custom_components.tahoma.config_flow] DHCP discovery detected gateway 0402-1619-6362
2021-10-06 00:20:25 DEBUG (MainThread) [custom_components.tahoma.config_flow] Gateway 0402-1619-6362 is already configured
iMicknl commented 2 years ago

@p2544 are you sure you disabled it for a while, until logging in again? Are you not running any other integration/plugin somewhere that is accessing the same account?

This behavior happens already at first login and the integration will keep retrying. We are not even at the point where we change the update interval, since we get the error already on the first try.

Do you reboot your Home Assistant often?

p2544 commented 2 years ago

@p2544 are you sure you disabled it for a while, until logging in again? Are you not running any other integration/plugin somewhere that is accessing the same account?

This behavior happens already at first login and the integration will keep retrying. We are not even at the point where we change the update interval, since we get the error already on the first try.

Do you reboot your Home Assistant often?

  1. sorry forget to disabled it so now just do disable, for how long?
  2. another server also install tahoma, but not yet loging-in
  3. let see what will happen
  4. Just want to know why it is so difficult for this integration? does somfy product is not made for this?
tetienne commented 2 years ago

Just want to know why it is so difficult for this integration? does somfy product is not made for this?

We use an unofficial and undocumented API. Plus they didn’t think it to be used by something else than their website or application. Once closed, there is no more call done, which is not the case for HA, Domoticz, Jeedom, Homebridge, etc.

sichip commented 2 years ago

@p2544 are you sure you disabled it for a while, until logging in again? Are you not running any other integration/plugin somewhere that is accessing the same account? This behavior happens already at first login and the integration will keep retrying. We are not even at the point where we change the update interval, since we get the error already on the first try. Do you reboot your Home Assistant often?

1. sorry forget to disabled it so now just do disable, for how long?

2. another server also install tahoma, but not yet loging-in

3. let see what will happen

4. Just want to know why it is so difficult for this integration? does somfy product is not made for this?

I noticed in your screenshot that the Configure button, which contains the interval option, is still there, which means that you may not actually be on the master version. This is something I noticed when I switched versions, so I'd recommend going to the reinstall option, selecting master, then restarting HA. Here's what mine looks like: Screenshot_20211006-181037_Home Assistant

iMicknl commented 2 years ago

@p2544 you need to update to the latest version first, as we asked a few times... I have just released a new version, so you don't need to install the master branch anymore.

However, your issues should be resolved with the new version, but please follow instructions.

  1. Update to the latest version (you can see it when the 'Configure' button is gone, good spot @sichip)
  2. Remove your integration/account
  3. WAIT for half a day
  4. Reconfigure your account and make sure you don't have any other apps/integrations polling the same account via the old integration.
  5. It should work, just like the other users experienced.
p2544 commented 2 years ago

ok just found some notification for update [image: image.png]

Screenshot 2021-10-06 203111 On Wed, 6 Oct 2021 at 15:31, Mick Vleeshouwer @.***> wrote:

@p2544 https://github.com/p2544 you need to update to the latest version first, as we asked a few times... I have just released a new version, so you don't need to install the master branch anymore.

However, your issues should be resolved with the new version, but please follow instructions.

  1. Update to the latest version (you can see it when the 'Configure' button is gone, good spot @sichip https://github.com/sichip)
  2. Remove your integration/account
  3. WAIT for half a day
  4. Reconfigure your account and make sure you don't have any other apps/integrations polling the same account via the old integration.
  5. It should work, just like the other users experienced.

— You are receiving this because you were mentioned. Reply to this email directly, view it on GitHub https://github.com/iMicknl/ha-tahoma/issues/586#issuecomment-935744856, or unsubscribe https://github.com/notifications/unsubscribe-auth/AF2IMAGVINLWOR4GPG3CTEDUFQCOLANCNFSM5EXDCGPQ . Triage notifications on the go with GitHub Mobile for iOS https://apps.apple.com/app/apple-store/id1477376905?ct=notification-email&mt=8&pt=524675 or Android https://play.google.com/store/apps/details?id=com.github.android&referrer=utm_campaign%3Dnotification-email%26utm_medium%3Demail%26utm_source%3Dgithub.

p2544 commented 2 years ago

reboot and come back again and found image

p2544 commented 2 years ago

already update and configure button still exist, should I wait until it gone? image

iMicknl commented 2 years ago

@p2544 please read my instructions, this would have saved me a lot of time...

WAIT for half a day was in the instruction list. Don't configure it yet.