trying to figure out why this is happening in 2022.9.0bx
suspect the new Zwave JS add-on or integration causing it, but no definitive conclusion yet
It also slows down HA startup to:
2022-09-05 15:38:57.273 INFO (MainThread) [homeassistant.bootstrap] Home Assistant initialized in 74.55s
where this was 30- secs consistently on 2022.8.x
2022-09-05 15:38:12.871 DEBUG (MainThread) [homeassistant.bootstrap] Waiting for startup to wrap up
2022-09-05 15:38:13.126 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 40 / 0>}
2022-09-05 15:38:13.126 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:14.129 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 39 / 0>}
2022-09-05 15:38:14.129 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:15.133 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 35 / 0>}
2022-09-05 15:38:15.133 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:16.135 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 34 / 0>}
2022-09-05 15:38:16.135 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:17.137 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 30 / 0>}
2022-09-05 15:38:17.138 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:18.139 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 28 / 0>}
2022-09-05 15:38:18.139 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:19.140 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 27 / 0>}
2022-09-05 15:38:19.141 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:20.142 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 25 / 0>}
2022-09-05 15:38:20.142 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:21.144 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 23 / 0>}
2022-09-05 15:38:21.144 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:22.151 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 21 / 0>}
2022-09-05 15:38:22.152 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:23.154 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 20 / 0>}
2022-09-05 15:38:23.154 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:24.156 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 19 / 0>}
2022-09-05 15:38:24.157 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:25.158 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 18 / 0>}
2022-09-05 15:38:25.158 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:26.159 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 16 / 0>}
2022-09-05 15:38:26.160 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:27.162 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 14 / 0>}
2022-09-05 15:38:27.163 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:28.164 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 13 / 0>}
2022-09-05 15:38:28.165 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:29.167 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 12 / 0>}
2022-09-05 15:38:29.168 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:30.169 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 12 / 0>}
2022-09-05 15:38:30.169 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:31.171 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:31.171 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:32.172 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:32.173 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:33.174 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:33.174 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:34.175 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:34.176 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:35.177 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:35.177 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:36.179 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:36.179 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:37.181 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:37.181 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:38.182 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:38.183 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:39.184 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:39.185 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:40.187 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:40.187 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:41.189 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:41.189 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:42.191 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:42.191 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:43.193 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:43.193 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:44.383 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:44.383 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:45.384 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:45.385 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:46.385 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:46.386 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:47.387 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 11 / 0>}
2022-09-05 15:38:47.387 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:48.183 ERROR (MainThread) [homeassistant.components.update] zwave_js: Error on device update!
Traceback (most recent call last):
File "/usr/src/homeassistant/homeassistant/helpers/entity_platform.py", line 477, in _async_add_entity
await entity.async_device_update(warning=False)
File "/usr/src/homeassistant/homeassistant/helpers/entity.py", line 703, in async_device_update
await task
File "/usr/src/homeassistant/homeassistant/components/zwave_js/update.py", line 108, in async_update
await self.driver.controller.async_get_available_firmware_updates(
File "/usr/local/lib/python3.10/site-packages/zwave_js_server/model/controller/__init__.py", line 719, in async_get_available_firmware_updates
data = await self.client.async_send_command(
File "/usr/local/lib/python3.10/site-packages/zwave_js_server/client.py", line 103, in async_send_command
return await future
zwave_js_server.exceptions.FailedZWaveCommand: Z-Wave error 260: Cannot check for firmware updates for node 85: Failed to query fingerprint from the node! (ZW0260)
2022-09-05 15:38:48.388 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 10 / 0>}
2022-09-05 15:38:48.389 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:49.389 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 9 / 0>}
2022-09-05 15:38:49.390 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:50.391 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 9 / 0>}
2022-09-05 15:38:50.392 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:51.398 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 8 / 0>}
2022-09-05 15:38:51.398 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:52.400 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 7 / 0>}
2022-09-05 15:38:52.400 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:53.401 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 5 / 0>}
2022-09-05 15:38:53.402 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:54.402 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 5 / 0>}
2022-09-05 15:38:54.403 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:55.403 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 3 / 0>}
2022-09-05 15:38:55.404 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}
2022-09-05 15:38:56.404 DEBUG (MainThread) [homeassistant.bootstrap] Running timeout Zones: {'update': <update: 2 / 0>}
2022-09-05 15:38:56.405 DEBUG (MainThread) [homeassistant.bootstrap] Integration remaining: {}