home-assistant / operating-system

:beginner: Home Assistant Operating System
Apache License 2.0
5.04k stars 986 forks source link

OS not properly reboot host #3440

Closed VenominousX closed 3 months ago

VenominousX commented 4 months ago

Describe the issue you are experiencing

Hello, I restart my hosts every morning, as this provides the best reliability of HA for me. However, with OS version 12.4, it seems that the host_reboot command is not working properly. After executing the command, the machine does not reboot completely, which is indicated by the status LED on the Mini PC. This does not flash, but lights up constantly as in normal operation. Subsequently, HA does not receive a correct network configuration:

2024-06-21 04:11:46.096 ERROR (MainThread) [async_upnp_client.ssdp] Received error: [Errno 101] Network unreachable, transport: <_SelectorDatagramTransport fd=32 read=polling write=<idle, bufsize=0>>, socket: <asyncio. TransportSocket fd=32, family=2, type=2, proto=0, laddr=('0.0.0.0', 49442)> 2024-06-21 04:11:46.097 ERROR (MainThread) [async_upnp_client.ssdp] An error was received: [Errno 99] address not available, transport: <_SelectorDatagramTransport fd=57 read=polling write=<idle, bufsize=0>>, socket: <asyncio.TransportSocket fd=57, family=10, type=2, proto=0, laddr=('::', 55125, 0, 0)>

Then some integrations like AsusRouter and remote_homeassistant cannot be started and block the boot process. However, deactivating the integrations would not help here either, as controlling the master via tablets does not work without a network configuration on the master.

However, a manual hard reset will get the system up and running again.

Best regards

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?

12.4

Did the problem occur after upgrading the Operating System?

Yes

Hardware details

AMD Ryzen 8845HS 64GB DDR5 RAM 1TB PCi 4.0 SSD Dual Edge TPU 2.5Gb Ethernet Conbee2 Stick

Steps to reproduce the issue

  1. Home Assistant Command: Host reboot

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

2024-06-21 08:11:37.962 INFO (MainThread) [supervisor.dbus.systemd] Load dbus interface org.freedesktop.systemd1
2024-06-21 08:11:37.962 INFO (MainThread) [supervisor.dbus.timedate] Load dbus interface org.freedesktop.timedate1
2024-06-21 08:11:38.023 INFO (MainThread) [supervisor.host.services] Updating service information
2024-06-21 08:11:38.024 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
2024-06-21 08:11:38.026 WARNING (SyncWorker_0) [supervisor.host.sound] Can't update PulseAudio data: Failed to connect to pulseaudio server
2024-06-21 08:11:38.075 INFO (MainThread) [supervisor.host.network] Updating local network information
2024-06-21 08:11:38.091 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'}
2024-06-21 08:11:48.913 WARNING (MainThread) [supervisor.utils.whoami] Can't fetch Whoami data: Timeout
2024-06-21 08:11:48.913 WARNING (MainThread) [supervisor.core] Can't adjust Time/Date settings: Can't fetch Whoami data: Timeout
2024-06-21 08:11:48.917 INFO (MainThread) [supervisor.docker.monitor] Started docker events monitor
2024-06-21 08:11:59.913 WARNING (MainThread) [supervisor.jobs] 'Updater.fetch_data' blocked from execution, no supervisor internet connection
2024-06-21 08:11:59.922 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-cli with version 2024.05.0
2024-06-21 08:11:59.932 INFO (MainThread) [supervisor.plugins.cli] Starting CLI plugin
2024-06-21 08:12:00.129 INFO (MainThread) [supervisor.docker.cli] Starting CLI ghcr.io/home-assistant/amd64-hassio-cli with version 2024.05.0 - 172.30.32.5
2024-06-21 08:12:00.135 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-dns with version 2024.04.0
2024-06-21 08:12:00.144 INFO (MainThread) [supervisor.plugins.dns] Starting CoreDNS plugin
2024-06-21 08:12:00.322 INFO (MainThread) [supervisor.docker.dns] Starting DNS ghcr.io/home-assistant/amd64-hassio-dns with version 2024.04.0 - 172.30.32.3
2024-06-21 08:12:00.322 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf
2024-06-21 08:12:10.943 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-audio with version 2023.12.0
2024-06-21 08:12:10.952 INFO (MainThread) [supervisor.plugins.audio] Starting Audio plugin
2024-06-21 08:12:11.155 INFO (MainThread) [supervisor.docker.audio] Starting Audio ghcr.io/home-assistant/amd64-hassio-audio with version 2023.12.0 - 172.30.32.4
2024-06-21 08:12:11.156 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-observer with version 2023.06.0
2024-06-21 08:12:11.163 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-multicast with version 2024.03.0
2024-06-21 08:12:11.167 INFO (MainThread) [supervisor.plugins.multicast] Starting Multicast plugin
2024-06-21 08:12:11.257 INFO (MainThread) [supervisor.docker.multicast] Starting Multicast ghcr.io/home-assistant/amd64-hassio-multicast with version 2024.03.0 - Host
2024-06-21 08:12:11.259 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 2 Home Assistant secrets
2024-06-21 08:12:11.263 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/generic-x86-64-homeassistant with version 2024.6.3
2024-06-21 08:12:11.281 INFO (MainThread) [supervisor.os.manager] Detect Home Assistant Operating System 12.4 / BootSlot B
2024-06-21 08:12:11.417 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/5c53de3b repository
2024-06-21 08:12:11.418 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/47701997 repository
2024-06-21 08:12:11.418 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/core repository
2024-06-21 08:12:11.418 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/a0d7b954 repository
2024-06-21 08:12:11.419 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/75f2ff60 repository
2024-06-21 08:12:11.505 INFO (MainThread) [supervisor.store] Loading add-ons from store: 100 all - 100 new - 0 remove
2024-06-21 08:12:11.521 INFO (MainThread) [supervisor.addons.manager] Found 5 installed add-ons
2024-06-21 08:12:11.527 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/vscode/amd64 with version 5.15.0
2024-06-21 08:12:11.529 INFO (MainThread) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-configurator with version 5.8.0
2024-06-21 08:12:11.534 INFO (MainThread) [supervisor.docker.interface] Attaching to homeassistant/amd64-addon-piper with version 1.5.0
2024-06-21 08:12:11.535 INFO (MainThread) [supervisor.docker.interface] Attaching to 47701997/amd64-addon-vosk with version 1.6.0
2024-06-21 08:12:11.538 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/sqlite-web/amd64 with version 4.1.2
2024-06-21 08:12:11.561 INFO (MainThread) [supervisor.backups.manager] Found 3 backup files
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.discovery] Loaded 2 messages
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.ingress] Loaded 2 ingress sessions
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state setup
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.checks.base] Run check for detached_addon_removed/addon
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.checks.base] Run check for disabled_data_disk/system
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.checks.base] Run check for multiple_data_disks/system
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.checks.base] Run check for detached_addon_missing/addon
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.check] System checks complete
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - setup
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
2024-06-21 08:12:11.564 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
2024-06-21 08:12:11.565 INFO (MainThread) [__main__] Running Supervisor
2024-06-21 08:12:11.567 INFO (MainThread) [supervisor.os.manager] Rauc: B - marked slot kernel.1 as good
2024-06-21 08:12:11.573 INFO (MainThread) [supervisor.addons.manager] Phase 'initialize' starting 0 add-ons
2024-06-21 08:12:11.576 INFO (MainThread) [supervisor.addons.manager] Phase 'system' starting 0 add-ons
2024-06-21 08:12:11.576 INFO (MainThread) [supervisor.addons.manager] Phase 'services' starting 1 add-ons
2024-06-21 08:12:11.755 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/vscode/amd64 with version 5.15.0
2024-06-21 08:12:41.826 INFO (MainThread) [supervisor.core] Start Home Assistant Core
2024-06-21 08:12:41.833 INFO (SyncWorker_8) [supervisor.docker.manager] Starting homeassistant
2024-06-21 08:12:41.908 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready
2024-06-21 08:12:43.128 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state startup
2024-06-21 08:12:43.128 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
2024-06-21 08:12:46.919 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
2024-06-21 08:12:46.921 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant Core state changed to NOT_RUNNING
2024-06-21 08:13:07.144 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant Core state changed to STARTING
2024-06-21 08:13:22.166 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant Core state changed to RUNNING
2024-06-21 08:13:22.166 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance
2024-06-21 08:13:22.166 INFO (MainThread) [supervisor.addons.manager] Phase 'application' starting 2 add-ons
2024-06-21 08:13:22.367 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on homeassistant/amd64-addon-piper with version 1.5.0
2024-06-21 08:13:22.570 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on 47701997/amd64-addon-vosk with version 1.6.0
2024-06-21 08:13:54.608 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled
2024-06-21 08:13:54.609 INFO (MainThread) [supervisor.core] Supervisor is up and running
2024-06-21 08:13:54.609 INFO (MainThread) [supervisor.host.info] Updating local host information
2024-06-21 08:13:54.610 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state running
2024-06-21 08:13:54.610 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_failed/dns_server
2024-06-21 08:13:54.815 INFO (MainThread) [supervisor.host.services] Updating service information
2024-06-21 08:13:54.817 INFO (MainThread) [supervisor.host.network] Updating local network information
2024-06-21 08:13:54.838 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
2024-06-21 08:13:54.841 INFO (MainThread) [supervisor.host.manager] Host information reload completed
2024-06-21 08:14:04.913 INFO (MainThread) [supervisor.jobs] 'CheckDNSServer.run_check' blocked from execution, no supervisor internet connection
2024-06-21 08:14:04.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for disabled_data_disk/system
2024-06-21 08:14:04.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for multiple_data_disks/system
2024-06-21 08:14:04.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for trust/supervisor
2024-06-21 08:14:04.915 WARNING (MainThread) [supervisor.jobs] 'Updater.fetch_data' blocked from execution, no supervisor internet connection
2024-06-21 08:14:04.918 INFO (MainThread) [supervisor.resolution.checks.base] Run check for pwned/addon
2024-06-21 08:14:15.913 INFO (MainThread) [supervisor.jobs] 'CheckAddonPwned.run_check' blocked from execution, no supervisor internet connection
2024-06-21 08:14:15.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for free_space/system
2024-06-21 08:14:15.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_ipv6_error/dns_server
2024-06-21 08:14:26.912 INFO (MainThread) [supervisor.jobs] 'CheckDNSServerIPv6.run_check' blocked from execution, no supervisor internet connection
2024-06-21 08:14:26.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for no_current_backup/system
2024-06-21 08:14:26.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for ipv4_connection_problem/system
2024-06-21 08:14:26.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for security/core
2024-06-21 08:14:26.913 INFO (MainThread) [supervisor.resolution.checks.base] Run check for docker_config/system
2024-06-21 08:14:26.913 INFO (MainThread) [supervisor.resolution.check] System checks complete
2024-06-21 08:14:26.913 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state running
2024-06-21 08:14:26.962 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
2024-06-21 08:14:26.962 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state running
2024-06-21 08:14:26.962 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

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

2024-06-21 06:12:11.250 homeassistant systemd-resolved[535]: Hostname conflict, changing published hostname from 'homeassistant' to 'homeassistant3'.
2024-06-21 06:12:11.618 homeassistant kernel: hassio: port 6(vethbf652ea) entered blocking state
2024-06-21 06:12:11.618 homeassistant kernel: hassio: port 6(vethbf652ea) entered disabled state
2024-06-21 06:12:11.618 homeassistant kernel: vethbf652ea: entered allmulticast mode
2024-06-21 06:12:11.618 homeassistant kernel: vethbf652ea: entered promiscuous mode
2024-06-21 06:12:11.618 homeassistant kernel: hassio: port 6(vethbf652ea) entered blocking state
2024-06-21 06:12:11.618 homeassistant kernel: hassio: port 6(vethbf652ea) entered forwarding state
2024-06-21 06:12:11.618 homeassistant NetworkManager[538]: <info>  [1718950331.6184] manager: (vethf277e67): new Veth device (/org/freedesktop/NetworkManager/Devices/18)
2024-06-21 06:12:11.618 homeassistant NetworkManager[538]: <info>  [1718950331.6187] manager: (vethbf652ea): new Veth device (/org/freedesktop/NetworkManager/Devices/19)
2024-06-21 06:12:11.669 homeassistant systemd[1]: Started libcontainer container b462f308f806c0612fd830abd191bcfa99eaedec090710c7c4235a81c9eaa24d.
2024-06-21 06:12:11.726 homeassistant kernel: eth0: renamed from vethf277e67
2024-06-21 06:12:11.742 homeassistant NetworkManager[538]: <info>  [1718950331.7423] device (vethbf652ea): carrier: link connected
2024-06-21 06:12:11.744 homeassistant systemd-resolved[535]: System hostname changed to 'homeassistant'.
2024-06-21 06:12:11.806 homeassistant systemd-resolved[535]: Detected conflict on homeassistant.local IN A 10.11.12.2
2024-06-21 06:12:11.806 homeassistant systemd-resolved[535]: Hostname conflict, changing published hostname from 'homeassistant' to 'homeassistant11'.
2024-06-21 06:12:11.869 homeassistant systemd[1]: Bluetooth service was skipped because of an unmet condition check (ConditionPathIsDirectory=/sys/class/bluetooth).
2024-06-21 06:12:41.892 homeassistant systemd[1]: Started libcontainer container d9735b30d550b3878d0fe3f78062ebe60c9e1ecdcc5d4e4019cbf6b154798277.
2024-06-21 06:12:41.899 homeassistant systemd-resolved[535]: System hostname changed to 'homeassistant'.
2024-06-21 06:12:41.900 homeassistant kernel: kauditd_printk_skb: 98 callbacks suppressed
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1334 audit(1718950361.897:196): prog-id=49 op=LOAD
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1300 audit(1718950361.897:196): arch=c000003e syscall=321 success=yes exit=15 a0=5 a1=c00016d928 a2=78 a3=0 items=0 ppid=3133 pid=3143 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/usr/bin/runc" subj=unconfined key=(null)
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1327 audit(1718950361.897:196): proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64393733356233306435353062333837386430666533663738
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1334 audit(1718950361.898:197): prog-id=50 op=LOAD
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1300 audit(1718950361.898:197): arch=c000003e syscall=321 success=yes exit=17 a0=5 a1=c00016d6c0 a2=78 a3=0 items=0 ppid=3133 pid=3143 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/usr/bin/runc" subj=unconfined key=(null)
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1327 audit(1718950361.898:197): proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64393733356233306435353062333837386430666533663738
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1334 audit(1718950361.898:198): prog-id=50 op=UNLOAD
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1300 audit(1718950361.898:198): arch=c000003e syscall=3 success=yes exit=0 a0=11 a1=0 a2=0 a3=0 items=0 ppid=3133 pid=3143 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="runc" exe="/usr/bin/runc" subj=unconfined key=(null)
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1327 audit(1718950361.898:198): proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F64393733356233306435353062333837386430666533663738
2024-06-21 06:12:41.900 homeassistant kernel: audit: type=1334 audit(1718950361.898:199): prog-id=49 op=UNLOAD
2024-06-21 06:12:42.055 homeassistant systemd-resolved[535]: Detected conflict on homeassistant IN A 10.11.12.2
2024-06-21 06:12:42.055 homeassistant systemd-resolved[535]: Hostname conflict, changing published hostname from 'homeassistant' to 'homeassistant8'.
2024-06-21 06:13:22.210 homeassistant systemd[1]: var-lib-docker-overlay2-deff4bf56b131452545bb98f0acd6d57b6b7a9829e6edfdd0085faca94a2e2c6\x2dinit-merged.mount: Deactivated successfully.
2024-06-21 06:13:22.211 homeassistant systemd[1]: mnt-data-docker-overlay2-deff4bf56b131452545bb98f0acd6d57b6b7a9829e6edfdd0085faca94a2e2c6\x2dinit-merged.mount: Deactivated successfully.
2024-06-21 06:13:22.231 homeassistant kernel: hassio: port 7(vethe3060a4) entered blocking state
2024-06-21 06:13:22.231 homeassistant kernel: hassio: port 7(vethe3060a4) entered disabled state
2024-06-21 06:13:22.231 homeassistant kernel: vethe3060a4: entered allmulticast mode
2024-06-21 06:13:22.231 homeassistant kernel: vethe3060a4: entered promiscuous mode
2024-06-21 06:13:22.231 homeassistant kernel: kauditd_printk_skb: 5 callbacks suppressed
2024-06-21 06:13:22.231 homeassistant kernel: audit: type=1700 audit(1718950402.229:201): dev=vethe3060a4 prom=256 old_prom=0 auid=4294967295 uid=0 gid=0 ses=4294967295
2024-06-21 06:13:22.231 homeassistant kernel: audit: type=1300 audit(1718950402.229:201): arch=c000003e syscall=44 success=yes exit=40 a0=d a1=c001ca8630 a2=28 a3=0 items=0 ppid=1 pid=644 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="dockerd" exe="/usr/bin/dockerd" subj=unconfined key=(null)
2024-06-21 06:13:22.231 homeassistant kernel: audit: type=1327 audit(1718950402.229:201): proctitle=2F7573722F62696E2F646F636B657264002D480066643A2F2F002D2D636F6E7461696E6572643D2F72756E2F636F6E7461696E6572642F636F6E7461696E6572642E736F636B
2024-06-21 06:13:22.231 homeassistant kernel: hassio: port 7(vethe3060a4) entered blocking state
2024-06-21 06:13:22.231 homeassistant kernel: hassio: port 7(vethe3060a4) entered forwarding state
2024-06-21 06:13:22.231 homeassistant kernel: hassio: port 7(vethe3060a4) entered disabled state
2024-06-21 06:13:22.231 homeassistant NetworkManager[538]: <info>  [1718950402.2313] manager: (veth8243d88): new Veth device (/org/freedesktop/NetworkManager/Devices/20)
2024-06-21 06:13:22.231 homeassistant NetworkManager[538]: <info>  [1718950402.2319] manager: (vethe3060a4): new Veth device (/org/freedesktop/NetworkManager/Devices/21)
2024-06-21 06:13:22.241 homeassistant kernel: audit: type=1325 audit(1718950402.239:202): table=nat:72 family=2 entries=1 op=nft_register_rule pid=3422 subj=unconfined comm="iptables"
2024-06-21 06:13:22.241 homeassistant kernel: audit: type=1300 audit(1718950402.239:202): arch=c000003e syscall=46 success=yes exit=508 a0=3 a1=7fffca289390 a2=0 a3=7fffca28937c items=0 ppid=644 pid=3422 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)
2024-06-21 06:13:22.241 homeassistant kernel: audit: type=1327 audit(1718950402.239:202): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D74006E6174002D4100444F434B4552002D7000746370002D6400302F30002D2D64706F7274003130323030002D6A00444E4154002D2D746F2D64657374696E6174696F6E003137322E33302E33332E313A31303230300000002D690068617373696F
2024-06-21 06:13:22.242 homeassistant kernel: audit: type=1325 audit(1718950402.240:203): table=filter:73 family=2 entries=1 op=nft_register_rule pid=3435 subj=unconfined comm="iptables"
2024-06-21 06:13:22.242 homeassistant kernel: audit: type=1300 audit(1718950402.240:203): arch=c000003e syscall=46 success=yes exit=648 a0=3 a1=7fff4f6cf2b0 a2=0 a3=7fff4f6cf29c items=0 ppid=644 pid=3435 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)
2024-06-21 06:13:22.242 homeassistant kernel: audit: type=1327 audit(1718950402.240:203): proctitle=2F7573722F7362696E2F69707461626C6573002D2D77616974002D740066696C746572002D4100444F434B45520000002D690068617373696F002D6F0068617373696F002D7000746370002D64003137322E33302E33332E31002D2D64706F7274003130323030002D6A00414343455054
2024-06-21 06:13:22.245 homeassistant kernel: audit: type=1325 audit(1718950402.242:204): table=nat:74 family=2 entries=1 op=nft_register_rule pid=3440 subj=unconfined comm="iptables"
2024-06-21 06:13:22.292 homeassistant systemd[1]: Started libcontainer container a4b62486a7204eeb0d248822df40392108b344546cc553e062492b68cd7997fc.
2024-06-21 06:13:22.347 homeassistant kernel: eth0: renamed from veth8243d88
2024-06-21 06:13:22.355 homeassistant kernel: hassio: port 7(vethe3060a4) entered blocking state
2024-06-21 06:13:22.355 homeassistant kernel: hassio: port 7(vethe3060a4) entered forwarding state
2024-06-21 06:13:22.355 homeassistant NetworkManager[538]: <info>  [1718950402.3557] device (vethe3060a4): carrier: link connected
2024-06-21 06:13:22.357 homeassistant systemd-resolved[535]: System hostname changed to 'homeassistant'.
2024-06-21 06:13:22.414 homeassistant kernel: hassio: port 8(veth6f72a3d) entered blocking state
2024-06-21 06:13:22.414 homeassistant kernel: hassio: port 8(veth6f72a3d) entered disabled state
2024-06-21 06:13:22.414 homeassistant kernel: veth6f72a3d: entered allmulticast mode
2024-06-21 06:13:22.414 homeassistant kernel: veth6f72a3d: entered promiscuous mode
2024-06-21 06:13:22.414 homeassistant kernel: hassio: port 8(veth6f72a3d) entered blocking state
2024-06-21 06:13:22.414 homeassistant kernel: hassio: port 8(veth6f72a3d) entered forwarding state
2024-06-21 06:13:22.414 homeassistant NetworkManager[538]: <info>  [1718950402.4143] manager: (veth828ee1a): new Veth device (/org/freedesktop/NetworkManager/Devices/22)
2024-06-21 06:13:22.414 homeassistant systemd-resolved[535]: Detected conflict on homeassistant IN A 10.11.12.2
2024-06-21 06:13:22.414 homeassistant systemd-resolved[535]: Hostname conflict, changing published hostname from 'homeassistant' to 'homeassistant10'.
2024-06-21 06:13:22.414 homeassistant NetworkManager[538]: <info>  [1718950402.4149] manager: (veth6f72a3d): new Veth device (/org/freedesktop/NetworkManager/Devices/23)
2024-06-21 06:13:22.473 homeassistant systemd[1]: Started libcontainer container 33e731f4603490eb949ece49db4421710dd9941fe3f2ebc2b19583f73eda2d19.
2024-06-21 06:13:22.541 homeassistant kernel: eth0: renamed from veth828ee1a
2024-06-21 06:13:22.557 homeassistant NetworkManager[538]: <info>  [1718950402.5571] device (veth6f72a3d): carrier: link connected
2024-06-21 06:13:22.559 homeassistant systemd-resolved[535]: System hostname changed to 'homeassistant'.
2024-06-21 06:13:22.805 homeassistant systemd-resolved[535]: Detected conflict on homeassistant IN A 10.11.12.2
2024-06-21 06:13:22.805 homeassistant systemd-resolved[535]: Hostname conflict, changing published hostname from 'homeassistant' to 'homeassistant4'.
2024-06-21 06:13:54.616 homeassistant kernel: kauditd_printk_skb: 94 callbacks suppressed
2024-06-21 06:13:54.616 homeassistant kernel: audit: type=1334 audit(1718950434.614:237): prog-id=60 op=LOAD
2024-06-21 06:13:54.616 homeassistant kernel: audit: type=1334 audit(1718950434.614:238): prog-id=61 op=LOAD
2024-06-21 06:13:54.616 homeassistant kernel: audit: type=1334 audit(1718950434.614:239): prog-id=62 op=LOAD
2024-06-21 06:13:54.637 homeassistant systemd[1]: Starting Hostname Service...
2024-06-21 06:13:54.712 homeassistant systemd[1]: Started Hostname Service.
2024-06-21 06:13:54.719 homeassistant kernel: audit: type=1334 audit(1718950434.717:240): prog-id=63 op=LOAD
2024-06-21 06:13:54.719 homeassistant kernel: audit: type=1334 audit(1718950434.717:241): prog-id=64 op=LOAD
2024-06-21 06:13:54.719 homeassistant kernel: audit: type=1334 audit(1718950434.717:242): prog-id=65 op=LOAD
2024-06-21 06:13:54.733 homeassistant systemd[1]: Starting Time & Date Service...
2024-06-21 06:13:54.800 homeassistant systemd[1]: Started Time & Date Service.
2024-06-21 06:14:05.054 homeassistant systemd-timesyncd[627]: Timed out waiting for reply from 162.159.200.1:123 (time.cloudflare.com).
2024-06-21 06:14:15.304 homeassistant systemd-timesyncd[627]: Timed out waiting for reply from 162.159.200.123:123 (time.cloudflare.com).
2024-06-21 06:14:24.745 homeassistant systemd[1]: systemd-hostnamed.service: Deactivated successfully.
2024-06-21 06:14:24.823 homeassistant kernel: audit: type=1334 audit(1718950464.821:243): prog-id=62 op=UNLOAD
2024-06-21 06:14:24.823 homeassistant kernel: audit: type=1334 audit(1718950464.821:244): prog-id=61 op=UNLOAD
2024-06-21 06:14:24.823 homeassistant kernel: audit: type=1334 audit(1718950464.821:245): prog-id=60 op=UNLOAD
2024-06-21 06:14:24.836 homeassistant systemd[1]: systemd-timedated.service: Deactivated successfully.
2024-06-21 06:14:24.844 homeassistant kernel: audit: type=1334 audit(1718950464.842:246): prog-id=65 op=UNLOAD
2024-06-21 06:14:24.844 homeassistant kernel: audit: type=1334 audit(1718950464.842:247): prog-id=64 op=UNLOAD
2024-06-21 06:14:24.844 homeassistant kernel: audit: type=1334 audit(1718950464.842:248): prog-id=63 op=UNLOAD
2024-06-21 06:14:42.949 homeassistant kernel: audit: type=1334 audit(1718950482.947:249): prog-id=66 op=LOAD
2024-06-21 06:14:42.951 homeassistant systemd-timesyncd[627]: Network configuration changed, trying to establish connection.
2024-06-21 06:14:42.961 homeassistant systemd[1]: Started Journal Gateway Service.
2024-06-21 06:14:53.054 homeassistant systemd-timesyncd[627]: Timed out waiting for reply from 162.159.200.123:123 (time.cloudflare.com).
2024-06-21 06:15:03.304 homeassistant systemd-timesyncd[627]: Timed out waiting for reply from 162.159.200.1:123 (time.cloudflare.com).

System information

System Information

version core-2024.6.3
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.12.2
os_name Linux
os_version 6.6.33-haos
arch x86_64
timezone Europe/Berlin
config_dir /config
Home Assistant Supervisor host_os | Home Assistant OS 12.4 -- | -- update_channel | stable supervisor_version | supervisor-2024.06.0 agent_version | 1.6.0 docker_version | 26.1.4 disk_total | 916.2 GB disk_used | 37.7 GB healthy | true supported | true host_connectivity | false supervisor_connectivity | false ntp_synchronized | false virtualization | board | generic-x86-64 supervisor_api | ok version_api | failed to load: timeout installed_addons | Studio Code Server (5.15.0), File editor (5.8.0), Piper (1.5.0), vosk (1.6.0), SQLite Web (4.1.2)
Dashboards dashboards | 1 -- | -- resources | 0 views | 6 mode | storage
Recorder oldest_recorder_run | 12. Juni 2024 um 20:38 -- | -- current_recorder_run | 21. Juni 2024 um 08:12 estimated_db_size | 275.79 MiB database_engine | sqlite database_version | 3.44.2

Additional information

As already mentioned, the master starts normally when I perform a hard reset. My master and the voice assist satellites are in a seperate subnet which blocks internet connection.

Downgrade to 12.3 solves the problem

cogneato commented 4 months ago

I'm not sure how related this is but you have multiple HA instances on the network? There appears to be a duel for the hostname

Hostname conflict, changing published hostname from 'homeassistant' to 'homeassistantX'. 

This appears several times with different attempts to assign a number. You can rename one of your hosts to avoid this at Settings > System > Network in HA. Are you rebooting both at the same time?

VenominousX commented 4 months ago

Hi, that's a good thought. However, this does not explain why a hard reset works without problems despite unchanged customization. It seems to have a different cause, as a fallback to 12.3 also works again without customization.

My satellites are started 1 minute earlier than the master. Both satellites already have 12.4 installed, start at the same time and have the same integrations. The difference to the master is that the satellites are Raspberry Pi's 4 and have no problems.

But I will try that, thanks

VenominousX commented 4 months ago

Update: I have changed the network name of all of my satellites, installed the OS 12.4 on my master and the host does not reboot after the host_reboot command, so the error still exists.

sairon commented 4 months ago

What does it mean "does not reboot completely"? What happens when you run the host_reboot service? Anything in Core or Host logs after that point? Does it behave correctly if you run ha host reboot in the terminal?

VenominousX commented 4 months ago

Hi, after the upgrade from 12.3 to 12.4 the host starts as usual. If a reboot is initiated with 12.4, the host does not boot. It is noticeable that the status LEDs on the LAN port then remain off. The host also does not come up again via the terminal. Since a hard reset solves the problem, I suspect the reboot process under 12.4. As soon as I go back to 12.3, everything works as usual. There are no anomalies in the home-assistant.log.1 or core log. However, since the host only boots after the hard reset, I don't know whether these statements are completely accurate.

home-assistant_2024-06-27T11-08-32.266Z.log host_2024-06-27T11-14-03.724Z.log

service: homeassistant.restart works without problems

VenominousX commented 4 months ago

Looks like the computer stucks in grub

VenominousX commented 4 months ago

There are 4 Options in Grub: Slot A (OK=1 TRY=0) Slot B (OK=1 TRY=1 - increments on boot, when not hard reseted) Slot A (rescue shell Slot B (rescue shell)

Slot A boots 12.3 Slot B boots 12.4

VenominousX commented 4 months ago

I did a complete reinstallation with the 12.4 image. The problem still exists. Going back to 12.3

VenominousX commented 3 months ago

Fixed with the OS version 13.0 Thank you very much :)