home-assistant / operating-system

:beginner: Home Assistant Operating System
Apache License 2.0
5.01k stars 981 forks source link

HA operating system update 11.0 --> Error setting up entry Supervisor for hassio #2816

Closed claustro closed 9 months ago

claustro commented 1 year ago

Describe the issue you are experiencing

I am having the error "Failed to setup supervisor" after updating to 11.0 . Even with this error all seems working correctly . I tried to reboot the machine without luck

What operating system image do you use?

generic-x86-64 (Generic UEFI capable x86-64 systems)

What version of Home Assistant Operating System is installed?

6.1.56

Did you upgrade the Operating System.

Yes

Steps to reproduce the issue

1. 2. 3. ...

Anything in the Supervisor logs that might be useful for us?

[32m23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to 00185a40/amd64-addon-simplescheduler with version 2.11
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-check_config with version 3.11.0
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-samba with version 10.0.2
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-configurator with version 5.6.0
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to sabeechen/hassio-google-drive-backup-amd64 with version 0.111.1
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-ssh with version 9.7.1
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/vscode/amd64 with version 5.11.0
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to zigbee2mqtt/zigbee2mqtt-amd64 with version 1.33.1-1
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-mosquitto with version 6.3.1
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/grafana/amd64 with version 9.0.3
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/node-red/amd64 with version 14.6.1
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/influxdb/amd64 with version 4.7.0
23-10-14 00:48:26 INFO (MainThread) [supervisor.docker.interface] Attaching to smeagolworms4/mqtt-explorer with version browser-1.0.1
23-10-14 00:48:26 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon TasmoAdmin is unhealthy, restarting...
23-10-14 00:48:26 INFO (SyncWorker_4) [supervisor.docker.manager] Stopping addon_a0d7b954_sonweb application
23-10-14 00:48:26 INFO (MainThread) [supervisor.backups.manager] Found 64 backup files
23-10-14 00:48:27 INFO (MainThread) [supervisor.discovery] Loaded 3 messages
23-10-14 00:48:27 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state setup
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.check] System checks complete
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
23-10-14 00:48:27 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - setup
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
23-10-14 00:48:27 INFO (MainThread) [__main__] Running Supervisor
23-10-14 00:48:27 INFO (MainThread) [supervisor.os.manager] Rauc: A - marked slot kernel.0 as good
23-10-14 00:48:27 INFO (MainThread) [supervisor.addons] Phase 'initialize' starting 0 add-ons
23-10-14 00:48:27 INFO (MainThread) [supervisor.core] Supervisor reboot detected
23-10-14 00:48:27 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled
23-10-14 00:48:27 INFO (MainThread) [supervisor.core] Supervisor is up and running
23-10-14 00:48:27 INFO (MainThread) [supervisor.host.info] Updating local host information
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state running
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for pwned/addon
23-10-14 00:48:27 INFO (MainThread) [supervisor.host.services] Updating service information
23-10-14 00:48:27 INFO (MainThread) [supervisor.host.network] Updating local network information
23-10-14 00:48:27 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
23-10-14 00:48:27 INFO (MainThread) [supervisor.host.manager] Host information reload completed
23-10-14 00:48:27 WARNING (MainThread) [supervisor.addons.options] Option 'dark_mode' does not exist in the schema for Node-RED (a0d7b954_nodered)
23-10-14 00:48:27 WARNING (MainThread) [supervisor.addons.options] Option 'require_ssl' does not exist in the schema for Node-RED (a0d7b954_nodered)
23-10-14 00:48:27 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request initialize
23-10-14 00:48:27 INFO (MainThread) [supervisor.api.proxy] WebSocket access from a0d7b954_nodered
23-10-14 00:48:27 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request running
23-10-14 00:48:27 WARNING (MainThread) [supervisor.addons.options] Option 'interface' does not exist in the schema for Samba share (core_samba)
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for ipv4_connection_problem/system
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for security/core
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for free_space/system
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for docker_config/system
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_ipv6_error/dns_server
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for multiple_data_disks/system
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for no_current_backup/system
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.module] Create new suggestion create_full_backup - system / None
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.module] Create new issue no_current_backup - system / None
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for trust/supervisor
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_failed/dns_server
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.check] System checks complete
23-10-14 00:48:27 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state running
23-10-14 00:48:28 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
23-10-14 00:48:28 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state running
23-10-14 00:48:28 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
23-10-14 00:48:31 INFO (SyncWorker_4) [supervisor.docker.manager] Cleaning addon_a0d7b954_sonweb application
23-10-14 00:48:31 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0
23-10-14 00:48:37 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup
23-10-14 00:48:37 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup

23-10-14 00:49:56 INFO (MainThread) [supervisor.auth] Auth request from 'core_mosquitto' for 'mqttuser'
23-10-14 00:49:56 INFO (MainThread) [supervisor.auth] Successful login for 'mqttuser'
23-10-14 00:50:01 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon TasmoAdmin is unhealthy, restarting...
23-10-14 00:50:01 INFO (SyncWorker_3) [supervisor.docker.manager] Stopping addon_a0d7b954_sonweb application
23-10-14 00:50:05 INFO (SyncWorker_3) [supervisor.docker.manager] Cleaning addon_a0d7b954_sonweb application
23-10-14 00:50:06 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0
23-10-14 00:50:27 WARNING (MainThread) [supervisor.misc.tasks] Watchdog missing application response from 6bfc5972_hasspyfrigate
23-10-14 00:51:36 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon TasmoAdmin is unhealthy, restarting...
23-10-14 00:51:36 INFO (SyncWorker_4) [supervisor.docker.manager] Stopping addon_a0d7b954_sonweb application
23-10-14 00:51:40 INFO (SyncWorker_4) [supervisor.docker.manager] Cleaning addon_a0d7b954_sonweb application
23-10-14 00:51:41 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0
23-10-14 00:52:27 WARNING (MainThread) [supervisor.misc.tasks] Watchdog found a problem with 6bfc5972_hasspyfrigate application!
23-10-14 00:52:27 INFO (SyncWorker_6) [supervisor.docker.manager] Stopping addon_6bfc5972_hasspyfrigate application
23-10-14 00:52:27 INFO (SyncWorker_6) [supervisor.docker.manager] Cleaning addon_6bfc5972_hasspyfrigate application
23-10-14 00:52:27 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on 6bfc5972/amd64-addon-hasspyfrigate with version 0.1
23-10-14 00:53:11 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon TasmoAdmin is unhealthy, restarting...
23-10-14 00:53:11 INFO (SyncWorker_6) [supervisor.docker.manager] Stopping addon_a0d7b954_sonweb application
23-10-14 00:53:15 INFO (SyncWorker_6) [supervisor.docker.manager] Cleaning addon_a0d7b954_sonweb application
23-10-14 00:53:16 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0

23-10-14 00:54:27 WARNING (MainThread) [supervisor.misc.tasks] Watchdog missing application response from 6bfc5972_hasspyfrigate
23-10-14 00:54:46 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon TasmoAdmin is unhealthy, restarting...
23-10-14 00:54:46 INFO (SyncWorker_4) [supervisor.docker.manager] Stopping addon_a0d7b954_sonweb application
23-10-14 00:54:50 INFO (SyncWorker_4) [supervisor.docker.manager] Cleaning addon_a0d7b954_sonweb application
23-10-14 00:54:50 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0
23-10-14 00:56:21 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon TasmoAdmin is unhealthy, restarting...
23-10-14 00:56:21 INFO (SyncWorker_4) [supervisor.docker.manager] Stopping addon_a0d7b954_sonweb application
23-10-14 00:56:25 INFO (SyncWorker_4) [supervisor.docker.manager] Cleaning addon_a0d7b954_sonweb application
23-10-14 00:56:25 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0
23-10-14 00:56:27 WARNING (MainThread) [supervisor.misc.tasks] Watchdog found a problem with 6bfc5972_hasspyfrigate application!
23-10-14 00:56:27 INFO (SyncWorker_0) [supervisor.docker.manager] Stopping addon_6bfc5972_hasspyfrigate application
23-10-14 00:56:28 INFO (SyncWorker_0) [supervisor.docker.manager] Cleaning addon_6bfc5972_hasspyfrigate application
23-10-14 00:56:28 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on 6bfc5972/amd64-addon-hasspyfrigate with version 0.1

Anything in the Host logs that might be useful for us?

Oct 13 22:54:50 homeassistant kernel: hassio: port 7(veth9fc21f3) entered disabled state
Oct 13 22:54:50 homeassistant NetworkManager[398]: <info>  [1697237690.4746] manager: (veth474bbf8): new Veth device (/org/freedesktop/NetworkManager/Devices/89)
Oct 13 22:54:50 homeassistant kernel: hassio: port 7(veth9fc21f3) entered disabled state
Oct 13 22:54:50 homeassistant kernel: device veth9fc21f3 left promiscuous mode
Oct 13 22:54:50 homeassistant kernel: hassio: port 7(veth9fc21f3) entered disabled state
Oct 13 22:54:50 homeassistant systemd[1]: run-docker-netns-b760202bbfe1.mount: Deactivated successfully.
Oct 13 22:54:50 homeassistant systemd[1]: var-lib-docker-overlay2-a314e66eee976a79d990cd0e1b0805e1ce6c53e5ed6f25b4a8e834cbe737d9f6-merged.mount: Deactivated successfully.
Oct 13 22:54:50 homeassistant systemd[1]: mnt-data-docker-overlay2-a314e66eee976a79d990cd0e1b0805e1ce6c53e5ed6f25b4a8e834cbe737d9f6-merged.mount: Deactivated successfully.
Oct 13 22:54:50 homeassistant NetworkManager[398]: <info>  [1697237690.6344] manager: (veth6ebc3d4): new Veth device (/org/freedesktop/NetworkManager/Devices/90)
Oct 13 22:54:50 homeassistant kernel: hassio: port 7(veth0f49c03) entered blocking state
Oct 13 22:54:50 homeassistant kernel: hassio: port 7(veth0f49c03) entered disabled state
Oct 13 22:54:50 homeassistant kernel: device veth0f49c03 entered promiscuous mode
Oct 13 22:54:50 homeassistant NetworkManager[398]: <info>  [1697237690.6415] manager: (veth0f49c03): new Veth device (/org/freedesktop/NetworkManager/Devices/91)
Oct 13 22:54:50 homeassistant kernel: hassio: port 7(veth0f49c03) entered blocking state
Oct 13 22:54:50 homeassistant kernel: hassio: port 7(veth0f49c03) entered forwarding state
Oct 13 22:54:50 homeassistant systemd[1]: Started libcontainer container 10cf3a15d0e1d801e1a683bd3bf6fb8541a2840129f60529192f6c6db0e50bc1.
Oct 13 22:54:50 homeassistant kernel: eth0: renamed from veth6ebc3d4
Oct 13 22:54:50 homeassistant kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth0f49c03: link becomes ready
Oct 13 22:54:50 homeassistant NetworkManager[398]: <info>  [1697237690.8601] device (veth0f49c03): carrier: link connected
Oct 13 22:54:52 homeassistant systemd[1]: run-docker-runtime\x2drunc-moby-d6933f1ac83103aa6b800af002a7574e834f2509942f285d6adf8b6aeda07402-runc.Ox9P9m.mount: Deactivated successfully.
Oct 13 22:54:58 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:55:09 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:55:20 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:55:31 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:55:41 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:55:52 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:56:03 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:56:07 homeassistant systemd[1]: run-docker-runtime\x2drunc-moby-95677e6f402b72f1601cd2622ce7bad87cdb36e6806207e55cd7ab52ea99e0ac-runc.FwM9ux.mount: Deactivated successfully.
Oct 13 22:56:14 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:56:24 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:56:25 homeassistant systemd[1]: docker-10cf3a15d0e1d801e1a683bd3bf6fb8541a2840129f60529192f6c6db0e50bc1.scope: Deactivated successfully.
Oct 13 22:56:25 homeassistant kernel: kauditd_printk_skb: 52 callbacks suppressed
Oct 13 22:56:25 homeassistant kernel: audit: type=1334 audit(1697237785.182:850): prog-id=197 op=UNLOAD
Oct 13 22:56:25 homeassistant systemd[1]: docker-10cf3a15d0e1d801e1a683bd3bf6fb8541a2840129f60529192f6c6db0e50bc1.scope: Consumed 2.175s CPU time.
Oct 13 22:56:25 homeassistant dockerd[475]: time="2023-10-13T22:56:25.200836946Z" level=info msg="ignoring event" container=10cf3a15d0e1d801e1a683bd3bf6fb8541a2840129f60529192f6c6db0e50bc1 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 13 22:56:25 homeassistant kernel: audit: type=1325 audit(1697237785.234:851): table=nat:189 family=2 entries=1 op=nft_unregister_rule pid=39378 subj=unconfined comm="iptables"
Oct 13 22:56:25 homeassistant kernel: audit: type=1300 audit(1697237785.234:851): arch=c000003e syscall=46 success=yes exit=512 a0=3 a1=7ffe8b36b3d0 a2=0 a3=7ffe8b36b3bc items=0 ppid=475 pid=39378 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=unconfined key=(null)
Oct 13 22:56:25 homeassistant kernel: audit: type=1327 audit(1697237785.234:851): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4400444F434B4552002D7000746370002D6400302F30002D2D64706F72740039353431002D6A00444E4154002D2D746F2D64657374696E6174696F6E003137322E33302E33332E313A393534310000002D690068617373696F
Oct 13 22:56:25 homeassistant kernel: audit: type=1325 audit(1697237785.239:852): table=filter:190 family=2 entries=1 op=nft_unregister_rule pid=39383 subj=unconfined comm="iptables"
Oct 13 22:56:25 homeassistant kernel: audit: type=1300 audit(1697237785.239:852): arch=c000003e syscall=46 success=yes exit=652 a0=3 a1=7ffe132dd920 a2=0 a3=7ffe132dd90c items=0 ppid=475 pid=39383 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=unconfined key=(null)
Oct 13 22:56:25 homeassistant kernel: audit: type=1327 audit(1697237785.239:852): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4400444F434B45520000002D690068617373696F002D6F0068617373696F002D7000746370002D64003137322E33302E33332E31002D2D64706F72740039353431002D6A00414343455054
Oct 13 22:56:25 homeassistant kernel: audit: type=1325 audit(1697237785.244:853): table=nat:191 family=2 entries=1 op=nft_unregister_rule pid=39385 subj=unconfined comm="iptables"
Oct 13 22:56:25 homeassistant kernel: audit: type=1300 audit(1697237785.244:853): arch=c000003e syscall=46 success=yes exit=604 a0=3 a1=7ffdfdc24bf0 a2=0 a3=7ffdfdc24bdc items=0 ppid=475 pid=39385 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/usr/sbin/xtables-nft-multi" subj=unconfined key=(null)
Oct 13 22:56:25 homeassistant kernel: audit: type=1327 audit(1697237785.244:853): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4400504F5354524F5554494E47002D7000746370002D73003137322E33302E33332E31002D64003137322E33302E33332E31002D2D64706F72740039353431002D6A004D415351554552414445
Oct 13 22:56:25 homeassistant kernel: hassio: port 7(veth0f49c03) entered disabled state
Oct 13 22:56:25 homeassistant kernel: veth6ebc3d4: renamed from eth0
Oct 13 22:56:25 homeassistant NetworkManager[398]: <info>  [1697237785.2820] manager: (veth6ebc3d4): new Veth device (/org/freedesktop/NetworkManager/Devices/92)
Oct 13 22:56:25 homeassistant kernel: hassio: port 7(veth0f49c03) entered disabled state
Oct 13 22:56:25 homeassistant kernel: device veth0f49c03 left promiscuous mode
Oct 13 22:56:25 homeassistant kernel: hassio: port 7(veth0f49c03) entered disabled state
Oct 13 22:56:25 homeassistant systemd[1]: run-docker-netns-151ee36885bc.mount: Deactivated successfully.
Oct 13 22:56:25 homeassistant systemd[1]: var-lib-docker-overlay2-a4490d325ff8789d5df361623ceaaf98ce44ab64f3bb19baa1c2bb926ff544bc-merged.mount: Deactivated successfully.
Oct 13 22:56:25 homeassistant systemd[1]: mnt-data-docker-overlay2-a4490d325ff8789d5df361623ceaaf98ce44ab64f3bb19baa1c2bb926ff544bc-merged.mount: Deactivated successfully.
Oct 13 22:56:25 homeassistant kernel: hassio: port 7(vethe378fba) entered blocking state
Oct 13 22:56:25 homeassistant kernel: hassio: port 7(vethe378fba) entered disabled state
Oct 13 22:56:25 homeassistant kernel: device vethe378fba entered promiscuous mode
Oct 13 22:56:25 homeassistant kernel: hassio: port 7(vethe378fba) entered blocking state
Oct 13 22:56:25 homeassistant kernel: hassio: port 7(vethe378fba) entered forwarding state
Oct 13 22:56:25 homeassistant NetworkManager[398]: <info>  [1697237785.4616] manager: (veth200614f): new Veth device (/org/freedesktop/NetworkManager/Devices/93)
Oct 13 22:56:25 homeassistant NetworkManager[398]: <info>  [1697237785.4637] manager: (vethe378fba): new Veth device (/org/freedesktop/NetworkManager/Devices/94)
Oct 13 22:56:25 homeassistant systemd[1]: Started libcontainer container 4f03c5a11b4cf2cd09c6d7bd628bfbfc5930534fe32dfd20acbb2960c6066f0d.
Oct 13 22:56:25 homeassistant kernel: eth0: renamed from veth200614f
Oct 13 22:56:25 homeassistant kernel: IPv6: ADDRCONF(NETDEV_CHANGE): vethe378fba: link becomes ready
Oct 13 22:56:25 homeassistant NetworkManager[398]: <info>  [1697237785.6743] device (vethe378fba): carrier: link connected
Oct 13 22:56:26 homeassistant systemd[1]: run-docker-runtime\x2drunc-moby-8ebce94dc1ca5c2a7ea7c9cab8ac2e437c37351ddaf5e4d0876b9330bcf3436e-runc.25aFNx.mount: Deactivated successfully.
Oct 13 22:56:28 homeassistant systemd[1]: docker-400eca8293fc5a7e9f96ecc1ba20b7294aa9f94d8a2806d9099073902a7f6a2c.scope: Deactivated successfully.
Oct 13 22:56:28 homeassistant systemd[1]: docker-400eca8293fc5a7e9f96ecc1ba20b7294aa9f94d8a2806d9099073902a7f6a2c.scope: Consumed 20.349s CPU time.
Oct 13 22:56:28 homeassistant dockerd[475]: time="2023-10-13T22:56:28.271324948Z" level=info msg="ignoring event" container=400eca8293fc5a7e9f96ecc1ba20b7294aa9f94d8a2806d9099073902a7f6a2c module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 13 22:56:28 homeassistant kernel: hassio: port 16(veth68d3dad) entered disabled state
Oct 13 22:56:28 homeassistant kernel: veth9ef1d91: renamed from eth0
Oct 13 22:56:28 homeassistant NetworkManager[398]: <info>  [1697237788.3507] manager: (veth9ef1d91): new Veth device (/org/freedesktop/NetworkManager/Devices/95)
Oct 13 22:56:28 homeassistant kernel: hassio: port 16(veth68d3dad) entered disabled state
Oct 13 22:56:28 homeassistant kernel: device veth68d3dad left promiscuous mode
Oct 13 22:56:28 homeassistant kernel: hassio: port 16(veth68d3dad) entered disabled state
Oct 13 22:56:28 homeassistant systemd[1]: run-docker-netns-c2f748003625.mount: Deactivated successfully.
Oct 13 22:56:28 homeassistant systemd[1]: var-lib-docker-overlay2-abfaf73abd1aeb6e23dca0b99e6f49a9f152819fb82ff7307113259f49311756-merged.mount: Deactivated successfully.
Oct 13 22:56:28 homeassistant systemd[1]: mnt-data-docker-overlay2-abfaf73abd1aeb6e23dca0b99e6f49a9f152819fb82ff7307113259f49311756-merged.mount: Deactivated successfully.
Oct 13 22:56:28 homeassistant kernel: hassio: port 16(veth7285cde) entered blocking state
Oct 13 22:56:28 homeassistant kernel: hassio: port 16(veth7285cde) entered disabled state
Oct 13 22:56:28 homeassistant kernel: device veth7285cde entered promiscuous mode
Oct 13 22:56:28 homeassistant kernel: hassio: port 16(veth7285cde) entered blocking state
Oct 13 22:56:28 homeassistant kernel: hassio: port 16(veth7285cde) entered forwarding state
Oct 13 22:56:28 homeassistant NetworkManager[398]: <info>  [1697237788.5187] manager: (vethf5f69bc): new Veth device (/org/freedesktop/NetworkManager/Devices/96)
Oct 13 22:56:28 homeassistant NetworkManager[398]: <info>  [1697237788.5232] manager: (veth7285cde): new Veth device (/org/freedesktop/NetworkManager/Devices/97)
Oct 13 22:56:28 homeassistant systemd[1]: Started libcontainer container 2a150455585816b500b941a45edaaf744fc928d2540eaf47974ce365857bcc87.
Oct 13 22:56:28 homeassistant kernel: eth0: renamed from vethf5f69bc
Oct 13 22:56:28 homeassistant kernel: IPv6: ADDRCONF(NETDEV_CHANGE): veth7285cde: link becomes ready
Oct 13 22:56:28 homeassistant NetworkManager[398]: <info>  [1697237788.7459] device (veth7285cde): carrier: link connected
Oct 13 22:56:31 homeassistant kernel: kauditd_printk_skb: 114 callbacks suppressed
Oct 13 22:56:31 homeassistant kernel: audit: type=1334 audit(1697237791.190:898): prog-id=209 op=LOAD
Oct 13 22:56:31 homeassistant systemd-timesyncd[461]: Network configuration changed, trying to establish connection.
Oct 13 22:56:31 homeassistant systemd[1]: Started Journal Gateway Service.
Oct 13 22:56:31 homeassistant systemd-timesyncd[461]: Contacted time server 162.159.200.1:123 (time.cloudflare.com).
Oct 13 22:56:31 homeassistant systemd-journal-gatewayd[40417]: microhttpd: MHD_OPTION_EXTERNAL_LOGGER is not the first option specified for the daemon. Some messages may be printed by the standard MHD logger.
Oct 13 22:56:35 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:56:46 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:56:57 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:57:07 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:57:18 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:57:29 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005
Oct 13 22:57:40 homeassistant kernel: Bluetooth: hci0: unexpected event for opcode 0x2005

System information

System Information

version core-2023.10.1
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.11.5
os_name Linux
os_version 6.1.56
arch x86_64
timezone Europe/Rome
config_dir /config
Home Assistant Community Store GitHub API | ok -- | -- GitHub Content | ok GitHub Web | ok GitHub API Calls Remaining | 4788 Installed Version | 1.32.1 Stage | running Available Repositories | 1318 Downloaded Repositories | 33
Home Assistant Cloud logged_in | false -- | -- can_reach_cert_server | ok can_reach_cloud_auth | ok can_reach_cloud | ok
Home Assistant Supervisor host_os | Home Assistant OS 11.0 -- | -- update_channel | stable supervisor_version | supervisor-2023.10.0 agent_version | 1.6.0 docker_version | 24.0.6 disk_total | 916.2 GB disk_used | 67.0 GB healthy | true supported | true board | generic-x86-64 supervisor_api | ok version_api | ok installed_addons | AdGuard Home (4.8.15), Advanced SSH & Web Terminal (15.0.8), Check Home Assistant configuration (3.11.0), Dropbox Sync (1.3.0), Duck DNS (1.15.0), ESPHome (1.14.3), ESPHome (2023.9.3), File editor (5.6.0), Frigate (0.12.1), HassPyFrigate (0.1), Home Assistant Google Drive Backup (0.111.1), Log Viewer (0.15.1), Mosquitto broker (6.3.1), Node-RED (14.6.1), Samba share (10.0.2), Simple Scheduler (2.11), Studio Code Server (5.11.0), TasmoAdmin (0.25.0), Terminal & SSH (9.7.1), Zigbee2MQTT (1.33.1-1), InfluxDB (4.7.0), Grafana (9.0.3), MQTT Explorer (browser-1.0.1)
Dashboards dashboards | 2 -- | -- resources | 25 views | 13 mode | storage
Recorder oldest_recorder_run | October 11, 2023 at 20:58 -- | -- current_recorder_run | October 14, 2023 at 00:40 estimated_db_size | 178.11 MiB database_engine | sqlite database_version | 3.41.2
Sonoff version | 3.5.1 (122751c) -- | -- cloud_online | 0 / 1 local_online | 1 / 1
Spotify api_endpoint_reachable | ok -- | --

Additional information

No response

cmd85 commented 1 year ago

In same boat, Supervisor have failed for me, not sure how to fix it.

agners commented 1 year ago

From the logs it seems that Tasmota add-on was holding up the boot process, and got declared as unhealthy.

�[32m23-10-14 00:48:31 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/tasmoadmin/amd64 with version 0.25.0�[0m
�[32m23-10-14 00:48:37 INFO (MainThread) [supervisor.api.middleware.security] /supervisor/info access from cebe7a76_hassio_google_drive_backup�[0m
�[32m23-10-14 00:48:37 INFO (MainThread) [supervisor.api.middleware.security] /backups access from cebe7a76_hassio_google_drive_backup�[0m
�[32m23-10-14 00:49:56 INFO (MainThread) [supervisor.auth] Auth request from 'core_mosquitto' for 'mqttuser'�[0m
�[32m23-10-14 00:49:56 INFO (MainThread) [supervisor.auth] Successful login for 'mqttuser'�[0m
�[33m23-10-14 00:50:01 WARNING (MainThread) [supervisor.addons.addon] Watchdog found addon TasmoAdmin is unhealthy, restarting...�[0m

Is this problem reproducible on every system reboot? If so, can you disable the Tasmota add-on to see if that resolves the issue?

agners commented 1 year ago

In same boat, Supervisor have failed for me, not sure how to fix it.

Is your system reachable as well? If so, can you share the Supervisor logs (Settings > System > Logs, choose Supervisor on the top right).

claustro commented 1 year ago

From the logs it seems that Tasmota add-on was holding up the boot process, and got declared as unhealthy.

Is this problem reproducible on every system reboot? If so, can you disable the Tasmota add-on to see if that resolves the issue?

On reboot the Tasmota error is gone. Still having error on supervisor , the log show different errors every time I reboot

Now this one

23-10-14 11:11:36 ERROR (MainThread) [asyncio] Task exception was never retrieved future: <Task finished name='Task-27073' coro=<Repository.update() done, defined at /usr/src/supervisor/supervisor/store/repository.py:104> exception=StoreGitError()>

agners commented 1 year ago

There should be an error further above in the logs with details:

23-10-14 11:11:36 ERROR (MainThread) [asyncio] Task exception was never retrieved
future: <Task finished name='Task-27073' coro=<Repository.update() done, defined at /usr/src/supervisor/supervisor/store/repository.py:104> exception=StoreGitError()>

Typically this happens when the add-on git repository is not reachable in one way or another (e.g. Internet connectivity issue). Do you use Pi-hole or similar services?

claustro commented 1 year ago

Thank you for spending your time answering me, No no Pi-hole, am using Adguard as an addon. The fact that is going me crazy is that every time I restart HA I receive different errors in the supervisor log, but my system seems working correctly. I can't understand what this supervisor error should cause

This is the last log after cleaning and restarting HA

23-10-14 14:36:02 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/BeardedTek/BeardedTek-hassio-addons repository 23-10-14 14:36:02 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/adamoutler/Addons repository 23-10-14 14:36:02 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/home-assistant/addons repository 23-10-14 14:36:02 INFO (MainThread) [supervisor.store.git] Update add-on https://github.com/sabeechen/hassio-google-drive-backup repository 23-10-14 14:36:02 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json 23-10-14 14:36:32 WARNING (MainThread) [supervisor.misc.tasks] Watchdog miss API response from Home Assistant 23-10-14 14:38:14 ERROR (MainThread) [supervisor.store.git] Can't update https://github.com/home-assistant/addons repo: Cmd('git') failed due to: exit code(128) cmdline: git fetch -v --update-shallow --depth=1 -- origin stderr: 'fatal: unable to access 'https://github.com/home-assistant/addons/': Failed to connect to github.com port 443 after 131002 ms: Couldn't connect to server'. 23-10-14 14:38:14 INFO (MainThread) [supervisor.resolution.module] Create new suggestion execute_reset - store / core 23-10-14 14:38:14 INFO (MainThread) [supervisor.resolution.module] Create new issue corrupt_repository - store / core 23-10-14 14:38:14 ERROR (MainThread) [supervisor.store.git] Can't update https://github.com/marcelveldt/hassio-addons-repo repo: Cmd('git') failed due to: exit code(128) cmdline: git fetch -v --update-shallow --depth=1 -- origin stderr: 'fatal: unable to access 'https://github.com/marcelveldt/hassio-addons-repo/': Failed to connect to github.com port 443 after 131591 ms: Couldn't connect to server'. 23-10-14 14:38:14 INFO (MainThread) [supervisor.resolution.module] Create new suggestion execute_reset - store / 62c7908d 23-10-14 14:38:14 INFO (MainThread) [supervisor.resolution.module] Create new issue corrupt_repository - store / 62c7908d 23-10-14 14:38:14 WARNING (SyncWorker_2) [supervisor.addons.validate] Add-on config 'auto_uart' is deprecated, use 'uart'. Please report this to the maintainer of Z-Wave JS Server DEVELOPMENT 23-10-14 14:38:14 WARNING (SyncWorker_2) [supervisor.addons.validate] Add-on config 'devices' use a deprecated format, the new format uses a list of paths only. Please report this to the maintainer of Google Assistant Webserver 23-10-14 14:38:14 WARNING (SyncWorker_5) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of DeskPi Pro Active Cooling 23-10-14 14:38:14 WARNING (SyncWorker_4) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of Frigate (Full Access) Beta (0.13.0) 23-10-14 14:38:14 WARNING (SyncWorker_5) [supervisor.addons.validate] Add-on config 'auto_uart' is deprecated, use 'uart'. Please report this to the maintainer of Z-Wave JS Server DEVELOPMENT 23-10-14 14:38:14 WARNING (SyncWorker_5) [supervisor.addons.validate] Add-on config 'devices' use a deprecated format, the new format uses a list of paths only. Please report this to the maintainer of Google Assistant Webserver 23-10-14 14:38:14 WARNING (SyncWorker_0) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of DeskPi Pro Active Cooling 23-10-14 14:38:14 WARNING (SyncWorker_6) [supervisor.addons.validate] Add-on have full device access, and selective device access in the configuration. Please report this to the maintainer of Frigate (Full Access) Beta (0.13.0) 23-10-14 14:38:14 INFO (MainThread) [supervisor.store] Loading add-ons from store: 106 all - 0 new - 0 remove 23-10-14 14:38:14 INFO (MainThread) [supervisor.store] Loading add-ons from store: 106 all - 0 new - 0 remove 23-10-14 14:38:14 ERROR (MainThread) [asyncio] Task exception was never retrieved future: <Task finished name='Task-55949' coro=<Repository.update() done, defined at /usr/src/supervisor/supervisor/store/repository.py:104> exception=StoreGitError()> Traceback (most recent call last): File "/usr/src/supervisor/supervisor/store/git.py", line 136, in pull await self.sys_run_in_executor( File "/usr/local/lib/python3.11/concurrent/futures/thread.py", line 58, in run result = self.fn(*self.args, **self.kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/site-packages/git/remote.py", line 1014, in fetch res = self._get_fetch_info_from_stderr(proc, progress, kill_after_timeout=kill_after_timeout) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/site-packages/git/remote.py", line 853, in _get_fetch_info_from_stderr proc.wait(stderr=stderr_text) File "/usr/local/lib/python3.11/site-packages/git/cmd.py", line 602, in wait raise GitCommandError(remove_password_if_present(self.args), status, errstr) git.exc.GitCommandError: Cmd('git') failed due to: exit code(128) cmdline: git fetch -v --update-shallow --depth=1 -- origin stderr: 'fatal: unable to access 'https://github.com/home-assistant/addons/': Failed to connect to github.com port 443 after 131002 ms: Couldn't connect to server'

The above exception was the direct cause of the following exception:

Traceback (most recent call last): File "/usr/src/supervisor/supervisor/store/repository.py", line 108, in update await self.git.pull() File "/usr/src/supervisor/supervisor/jobs/decorator.py", line 281, in wrapper raise err File "/usr/src/supervisor/supervisor/jobs/decorator.py", line 274, in wrapper return await self._method(obj, *args, *kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/supervisor/supervisor/store/git.py", line 178, in pull raise StoreGitError() from err supervisor.exceptions.StoreGitError 23-10-14 14:38:14 ERROR (MainThread) [asyncio] Task exception was never retrieved future: <Task finished name='Task-55946' coro=<Repository.update() done, defined at /usr/src/supervisor/supervisor/store/repository.py:104> exception=StoreGitError()> Traceback (most recent call last): File "/usr/src/supervisor/supervisor/store/git.py", line 136, in pull await self.sys_run_in_executor( File "/usr/local/lib/python3.11/concurrent/futures/thread.py", line 58, in run result = self.fn(self.args, **self.kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/site-packages/git/remote.py", line 1014, in fetch res = self._get_fetch_info_from_stderr(proc, progress, kill_after_timeout=kill_after_timeout) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/local/lib/python3.11/site-packages/git/remote.py", line 853, in _get_fetch_info_from_stderr proc.wait(stderr=stderr_text) File "/usr/local/lib/python3.11/site-packages/git/cmd.py", line 602, in wait raise GitCommandError(remove_password_if_present(self.args), status, errstr) git.exc.GitCommandError: Cmd('git') failed due to: exit code(128) cmdline: git fetch -v --update-shallow --depth=1 -- origin stderr: 'fatal: unable to access 'https://github.com/marcelveldt/hassio-addons-repo/': Failed to connect to github.com port 443 after 131591 ms: Couldn't connect to server'

The above exception was the direct cause of the following exception:

Traceback (most recent call last): File "/usr/src/supervisor/supervisor/store/repository.py", line 108, in update await self.git.pull() File "/usr/src/supervisor/supervisor/jobs/decorator.py", line 281, in wrapper raise err File "/usr/src/supervisor/supervisor/jobs/decorator.py", line 274, in wrapper return await self._method(obj, *args, **kwargs) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ File "/usr/src/supervisor/supervisor/store/git.py", line 178, in pull raise StoreGitError() from err supervisor.exceptions.StoreGitError 23-10-14 14:38:17 INFO (MainThread) [supervisor.auth] Auth request from 'core_mosquitto' for 'mqttuser' 23-10-14 14:38:17 INFO (MainThread) [supervisor.auth] Home Assistant not running, checking cache 23-10-14 14:38:25 INFO (MainThread) [supervisor.auth] Auth request from 'core_mosquitto' for 'mqttuser' 23-10-14 14:38:25 INFO (MainThread) [supervisor.auth] Home Assistant not running, checking cache 23-10-14 14:38:25 ERROR (MainThread) [supervisor.services.modules.mqtt] There is already a MQTT service in use from core_mosquitto 23-10-14 14:38:31 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance 23-10-14 14:38:31 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request initialize 23-10-14 14:38:31 INFO (MainThread) [supervisor.api.proxy] WebSocket access from a0d7b954_nodered 23-10-14 14:38:31 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request running

github-actions[bot] commented 9 months ago

There hasn't been any activity on this issue recently. To keep our backlog manageable we have to clean old issues, as many of them have already been resolved with the latest updates. Please make sure to update to the latest Home Assistant OS version and check if that solves the issue. Let us know if that works for you by adding a comment 👍 This issue has now been marked as stale and will be closed if no further activity occurs. Thank you for your contributions.