home-assistant / core

:house_with_garden: Open source home automation that puts local control and privacy first.
https://www.home-assistant.io
Apache License 2.0
74.09k stars 31.09k forks source link

updating state for update.home_assistant_supervisor_update #128817

Open NickSee opened 1 month ago

NickSee commented 1 month ago

The problem

Brand new homeassistant instance created yesterday on new media reported the following Warning overnight: Updating state for update.home_assistant_supervisor_update (<class 'homeassistant.components.hassio.update.SupervisorSupervisorUpdateEntity'>) took 0.421 seconds. Please create a bug report

What version of Home Assistant Core has the issue?

core-2024.10.3

What was the last working version of Home Assistant Core?

New instance

What type of installation are you running?

Home Assistant OS

Integration causing the issue

supervisor-2024.10.2

Link to integration documentation on our website

No response

Diagnostics information

Logger: homeassistant.helpers.entity Source: helpers/entity.py:1180 First occurred: 03:02:15 (1 occurrences) Last logged: 03:02:15

Updating state for update.home_assistant_supervisor_update (<class 'homeassistant.components.hassio.update.SupervisorSupervisorUpdateEntity'>) took 0.421 seconds. Please create a bug report at https://github.com/home-assistant/core/issues?q=is%3Aopen+is%3Aissue+label%3A%22integration%3A+hassio%22

Example YAML snippet

No response

Anything in the logs that might be useful for us?

Discovered this at 0730. Supervisor log entries are now starting at 03:03 i.e. one minute after the above issue and are all green (see below).
2024-10-20 03:03:37.115 INFO (MainThread) [supervisor.resolution.checks.base] Run check for trust/supervisor.
I only have 7 add-ons all in a brand new installed state and have checked all logs plus Host, DNS and there is either no correlation or logs start after the time of the event.
Whilst I've been completing this bug report, Home Assistant Core log now contains 9 x ERROR Failed to to call /supervisor/stats -
Failed to to call /core/stats - 
and 9 x Timeout on /supervisor/stats request
Timeout on /core/stats request.

I am probably on the limit of hardware running on a Pi 3B+ with temporarily a new Class 1 sd card (awaiting Class 2 arriving today).

Additional information

Last night at 23:30 (this is probably unrelated but mentioning in case relevant) I was surprised to see Supervisor log state that "NodeRed was unhealthy" because this is a brand new install on new media and Node Red contains no user injected content, it was a brand new installed add-on. Also was part of the reason to do a new install - as couldn't cure same reports on my mature 10 year old set up). Nothing in NodeRed log this morning beyond 23:52 though so no correlation with above 03:02 error.

NickSee commented 1 month ago

Although no correlation with 03:02 warning I have found that File Editor has been reporting every 0.6-0.9 seconds for quite some time. I have just used it to open a document (successfully with no problems). Here is a chunk of File Editor's log leading up to my first use of it this morning which then temporarily stopped the repetitive log entries: INFO:2024-10-20 07:45:39,935:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:46:30,741:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:47:24,223:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:48:20,057:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:49:27,926:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:50:23,813:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:51:19,380:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:52:01,106:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:52:53,877:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:53:44,680:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:54:40,410:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:55:22,831:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:55:51,007:hass_configurator.configurator:172.30.32.2 - "GET / HTTP/1.1" 200 - INFO:2024-10-20 07:55:52,507:hass_configurator.configurator:172.30.32.2 - "GET /material-icons.fallback.css HTTP/1.1" 200 - INFO:2024-10-20 07:55:52,598:hass_configurator.configurator:172.30.32.2 - "GET /style.css HTTP/1.1" 200 - INFO:2024-10-20 07:55:52,661:hass_configurator.configurator:172.30.32.2 - "GET /jquery-3.6.0.min.js HTTP/1.1" 200 - INFO:2024-10-20 07:55:52,665:hass_configurator.configurator:172.30.32.2 - "GET /materialize.min.js HTTP/1.1" 200 - INFO:2024-10-20 07:55:52,695:hass_configurator.configurator:172.30.32.2 - "GET /js-yaml.min.js HTTP/1.1" 200 - INFO:2024-10-20 07:55:52,921:hass_configurator.configurator:172.30.32.2 - "GET /flUhRq6tzZclQEJ-Vdg-IuiaDsNc.woff2 HTTP/1.1" 200 - INFO:2024-10-20 07:55:53,063:hass_configurator.configurator:172.30.32.2 - "GET /api/file?filename=/homeassistant/configuration.yaml HTTP/1.1" 200 - INFO:2024-10-20 07:55:53,358:hass_configurator.configurator:172.30.32.2 - "GET /api/listdir?path=. HTTP/1.1" 200 - INFO:2024-10-20 07:56:01,671:hass_configurator.configurator:127.0.0.1 - "GET / HTTP/1.1" 200 -