home-assistant / operating-system

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

Error message on console after upgrade to 12.0 #3195

Closed derolli1976 closed 8 months ago

derolli1976 commented 8 months ago

Describe the issue you are experiencing

image

Running on Hyper-V VM. Looks like everything else is working fine.

What operating system image do you use?

ova (for Virtual Machines)

What version of Home Assistant Operating System is installed?

12.0

Did you upgrade the Operating System.

Yes

Steps to reproduce the issue

  1. Update to 12.0 from previous release

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

24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.manager] Connected to system D-Bus.
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.agent] Load dbus interface io.hass.os
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.hostname] Load dbus interface org.freedesktop.hostname1
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.logind] Load dbus interface org.freedesktop.login1
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.network] Load dbus interface org.freedesktop.NetworkManager
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.rauc] Load dbus interface de.pengutronix.rauc
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.resolved] Load dbus interface org.freedesktop.resolve1
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.systemd] Load dbus interface org.freedesktop.systemd1
24-02-26 16:26:27 INFO (MainThread) [supervisor.dbus.timedate] Load dbus interface org.freedesktop.timedate1
24-02-26 16:26:27 INFO (MainThread) [supervisor.host.services] Updating service information
24-02-26 16:26:27 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
24-02-26 16:26:27 WARNING (SyncWorker_0) [supervisor.host.sound] Can't update PulseAudio data: Failed to connect to pulseaudio server
24-02-26 16:26:27 INFO (MainThread) [supervisor.host.network] Updating local network information
24-02-26 16:26:27 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'}
24-02-26 16:26:27 INFO (MainThread) [supervisor.docker.monitor] Started docker events monitor
24-02-26 16:26:27 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/beta.json
24-02-26 16:26:27 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-cli with version 2024.02.0
24-02-26 16:26:27 INFO (MainThread) [supervisor.plugins.cli] Starting CLI plugin
24-02-26 16:26:27 INFO (MainThread) [supervisor.docker.cli] Starting CLI ghcr.io/home-assistant/amd64-hassio-cli with version 2024.02.0 - 172.30.32.5
24-02-26 16:26:27 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-dns with version 2023.06.2
24-02-26 16:26:27 INFO (MainThread) [supervisor.plugins.dns] Starting CoreDNS plugin
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.dns] Starting DNS ghcr.io/home-assistant/amd64-hassio-dns with version 2023.06.2 - 172.30.32.3
24-02-26 16:26:28 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-audio with version 2023.12.0
24-02-26 16:26:28 INFO (MainThread) [supervisor.plugins.audio] Starting Audio plugin
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.audio] Starting Audio ghcr.io/home-assistant/amd64-hassio-audio with version 2023.12.0 - 172.30.32.4
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-observer with version 2023.06.0
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/amd64-hassio-multicast with version 2023.06.2
24-02-26 16:26:28 INFO (MainThread) [supervisor.plugins.multicast] Starting Multicast plugin
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.multicast] Starting Multicast ghcr.io/home-assistant/amd64-hassio-multicast with version 2023.06.2 - Host
24-02-26 16:26:28 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 1 Home Assistant secrets
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/qemux86-64-homeassistant with version 2024.2.3
24-02-26 16:26:28 INFO (MainThread) [supervisor.os.manager] Detect Home Assistant Operating System 12.0 / BootSlot A
24-02-26 16:26:28 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/a0d7b954 repository
24-02-26 16:26:28 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/git/5c53de3b repository
24-02-26 16:26:28 INFO (MainThread) [supervisor.store.git] Loading add-on /data/addons/core repository
24-02-26 16:26:28 INFO (MainThread) [supervisor.store] Loading add-ons from store: 77 all - 77 new - 0 remove
24-02-26 16:26:28 INFO (MainThread) [supervisor.addons.manager] Found 4 installed add-ons
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/ssh/amd64 with version 17.1.1
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/log-viewer/amd64 with version 0.17.0
24-02-26 16:26:28 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/node-red/amd64 with version 17.0.7
24-02-26 16:26:29 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/hassio-addons/vscode/amd64 with version 5.15.0
24-02-26 16:26:29 INFO (MainThread) [supervisor.backups.manager] Found 1 backup files
24-02-26 16:26:29 INFO (MainThread) [supervisor.discovery] Loaded 0 messages
24-02-26 16:26:29 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions
24-02-26 16:26:29 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state setup
24-02-26 16:26:29 INFO (MainThread) [supervisor.resolution.check] System checks complete
24-02-26 16:26:29 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
24-02-26 16:26:29 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
24-02-26 16:26:29 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - setup
24-02-26 16:26:29 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
24-02-26 16:26:29 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
24-02-26 16:26:29 INFO (MainThread) [__main__] Running Supervisor
24-02-26 16:26:29 INFO (MainThread) [supervisor.os.manager] Rauc: A - marked slot kernel.0 as good
24-02-26 16:26:29 INFO (MainThread) [supervisor.addons.manager] Phase 'initialize' starting 0 add-ons
24-02-26 16:26:29 INFO (MainThread) [supervisor.addons.manager] Phase 'system' starting 0 add-ons
24-02-26 16:26:29 INFO (MainThread) [supervisor.addons.manager] Phase 'services' starting 2 add-ons
24-02-26 16:26:29 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/ssh/amd64 with version 17.1.1
24-02-26 16:26:29 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/vscode/amd64 with version 5.15.0
24-02-26 16:26:59 INFO (MainThread) [supervisor.core] Start Home Assistant Core
24-02-26 16:26:59 INFO (SyncWorker_0) [supervisor.docker.manager] Starting homeassistant
24-02-26 16:26:59 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready
24-02-26 16:27:02 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state startup
24-02-26 16:27:02 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
24-02-26 16:27:06 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token
24-02-26 16:27:06 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant Core state changed to NOT_RUNNING
24-02-26 16:27:11 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant Core state changed to RUNNING
24-02-26 16:27:11 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance
24-02-26 16:27:11 INFO (MainThread) [supervisor.addons.manager] Phase 'application' starting 2 add-ons
24-02-26 16:27:11 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/node-red/amd64 with version 17.0.7
24-02-26 16:27:11 INFO (MainThread) [supervisor.docker.addon] Starting Docker add-on ghcr.io/hassio-addons/log-viewer/amd64 with version 0.17.0
24-02-26 16:27:21 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request initialize
24-02-26 16:27:21 INFO (MainThread) [supervisor.api.proxy] WebSocket access from a0d7b954_nodered
24-02-26 16:27:21 INFO (MainThread) [supervisor.api.proxy] Home Assistant WebSocket API request running
24-02-26 16:27:41 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled
24-02-26 16:27:41 INFO (MainThread) [supervisor.core] Supervisor is up and running
24-02-26 16:27:41 INFO (MainThread) [supervisor.host.info] Updating local host information
24-02-26 16:27:41 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/beta.json
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state running
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for multiple_data_disks/system
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for trust/supervisor
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_ipv6_error/dns_server
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_failed/dns_server
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for pwned/addon
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for docker_config/system
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for no_current_backup/system
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.module] Create new suggestion create_full_backup - system / None
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.module] Create new issue no_current_backup - system / None
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for security/core
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for free_space/system
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.checks.base] Run check for ipv4_connection_problem/system
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.check] System checks complete
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state running
24-02-26 16:27:41 INFO (MainThread) [supervisor.host.services] Updating service information
24-02-26 16:27:41 INFO (MainThread) [supervisor.host.network] Updating local network information
24-02-26 16:27:41 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
24-02-26 16:27:41 INFO (MainThread) [supervisor.host.manager] Host information reload completed
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state running
24-02-26 16:27:41 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

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

Feb 26 15:26:29 homeassistant-dev kernel: eth0: renamed from veth5afeb41
Feb 26 15:26:29 homeassistant-dev kernel: hassio: port 6(veth0a8ef44) entered blocking state
Feb 26 15:26:29 homeassistant-dev kernel: hassio: port 6(veth0a8ef44) entered forwarding state
Feb 26 15:26:29 homeassistant-dev NetworkManager[386]: <info>  [1708961189.4341] device (veth0a8ef44): carrier: link connected
Feb 26 15:26:40 homeassistant-dev systemd[1]: NetworkManager-dispatcher.service: Deactivated successfully.
Feb 26 15:26:57 homeassistant-dev systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Feb 26 15:26:57 homeassistant-dev kernel: kauditd_printk_skb: 233 callbacks suppressed
Feb 26 15:26:57 homeassistant-dev kernel: audit: type=1334 audit(1708961217.377:198): prog-id=14 op=UNLOAD
Feb 26 15:26:57 homeassistant-dev kernel: audit: type=1334 audit(1708961217.378:199): prog-id=13 op=UNLOAD
Feb 26 15:26:57 homeassistant-dev kernel: audit: type=1334 audit(1708961217.378:200): prog-id=12 op=UNLOAD
Feb 26 15:26:57 homeassistant-dev systemd[1]: systemd-timedated.service: Deactivated successfully.
Feb 26 15:26:57 homeassistant-dev kernel: audit: type=1334 audit(1708961217.416:201): prog-id=26 op=UNLOAD
Feb 26 15:26:57 homeassistant-dev kernel: audit: type=1334 audit(1708961217.416:202): prog-id=25 op=UNLOAD
Feb 26 15:26:57 homeassistant-dev kernel: audit: type=1334 audit(1708961217.416:203): prog-id=24 op=UNLOAD
Feb 26 15:26:59 homeassistant-dev systemd[1]: Started libcontainer container f35c4f9c86cd4bb50a0616676db0f9ef8b507ab9db8174a43ad42da71063da45.
Feb 26 15:26:59 homeassistant-dev kernel: audit: type=1334 audit(1708961219.621:204): prog-id=53 op=LOAD
Feb 26 15:26:59 homeassistant-dev kernel: audit: type=1300 audit(1708961219.621:204): arch=c000003e syscall=321 success=yes exit=15 a0=5 a1=c000131988 a2=78 a3=0 items=0 ppid=2764 pid=2773 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)
Feb 26 15:26:59 homeassistant-dev kernel: audit: type=1327 audit(1708961219.621:204): proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F66333563346639633836636434626235306130363136363736
Feb 26 15:26:59 homeassistant-dev kernel: audit: type=1334 audit(1708961219.621:205): prog-id=54 op=LOAD
Feb 26 15:27:03 homeassistant-dev systemd[1]: Bluetooth service was skipped because of an unmet condition check (ConditionPathIsDirectory=/sys/class/bluetooth).
Feb 26 15:27:03 homeassistant-dev systemd[1]: Bluetooth service was skipped because of an unmet condition check (ConditionPathIsDirectory=/sys/class/bluetooth).
Feb 26 15:27:03 homeassistant-dev kernel: Bluetooth: Core ver 2.22
Feb 26 15:27:03 homeassistant-dev kernel: NET: Registered PF_BLUETOOTH protocol family
Feb 26 15:27:03 homeassistant-dev kernel: Bluetooth: HCI device and connection manager initialized
Feb 26 15:27:03 homeassistant-dev kernel: Bluetooth: HCI socket layer initialized
Feb 26 15:27:03 homeassistant-dev kernel: Bluetooth: L2CAP socket layer initialized
Feb 26 15:27:03 homeassistant-dev kernel: Bluetooth: SCO socket layer initialized
Feb 26 15:27:10 homeassistant-dev kernel: hv_balloon: Max. dynamic memory size: 4096 MB
Feb 26 15:27:11 homeassistant-dev systemd[1]: var-lib-docker-overlay2-18478e2bd0ad1c20d63cd228f2813b1fcbfde2c2682c7498b49036bf20cd906b\x2dinit-merged.mount: Deactivated successfully.
Feb 26 15:27:11 homeassistant-dev systemd[1]: mnt-data-docker-overlay2-18478e2bd0ad1c20d63cd228f2813b1fcbfde2c2682c7498b49036bf20cd906b\x2dinit-merged.mount: Deactivated successfully.
Feb 26 15:27:11 homeassistant-dev systemd[1]: Started libcontainer container c7195e9abd4d3edbe2100366a0e77799981ce724bac4b622b705c1f7213bd795.
Feb 26 15:27:11 homeassistant-dev kernel: kauditd_printk_skb: 11 callbacks suppressed
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1334 audit(1708961231.305:209): prog-id=56 op=LOAD
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1334 audit(1708961231.306:210): prog-id=57 op=LOAD
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1300 audit(1708961231.306:210): arch=c000003e syscall=321 success=yes exit=16 a0=5 a1=c00018d988 a2=78 a3=0 items=0 ppid=2938 pid=2947 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)
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1327 audit(1708961231.306:210): proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F63373139356539616264346433656462653231303033363661
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1334 audit(1708961231.306:211): prog-id=58 op=LOAD
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1300 audit(1708961231.306:211): arch=c000003e syscall=321 success=yes exit=18 a0=5 a1=c00018d720 a2=78 a3=0 items=0 ppid=2938 pid=2947 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)
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1327 audit(1708961231.306:211): proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F63373139356539616264346433656462653231303033363661
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1334 audit(1708961231.306:212): prog-id=58 op=UNLOAD
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1300 audit(1708961231.306:212): arch=c000003e syscall=3 success=yes exit=0 a0=12 a1=0 a2=0 a3=0 items=0 ppid=2938 pid=2947 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)
Feb 26 15:27:11 homeassistant-dev kernel: audit: type=1327 audit(1708961231.306:212): proctitle=72756E63002D2D726F6F74002F7661722F72756E2F646F636B65722F72756E74696D652D72756E632F6D6F6279002D2D6C6F67002F72756E2F636F6E7461696E6572642F696F2E636F6E7461696E6572642E72756E74696D652E76322E7461736B2F6D6F62792F63373139356539616264346433656462653231303033363661
Feb 26 15:27:11 homeassistant-dev NetworkManager[386]: <info>  [1708961231.4425] manager: (veth063ce73): new Veth device (/org/freedesktop/NetworkManager/Devices/19)
Feb 26 15:27:11 homeassistant-dev NetworkManager[386]: <info>  [1708961231.4432] manager: (vethdbc4f0d): new Veth device (/org/freedesktop/NetworkManager/Devices/20)
Feb 26 15:27:11 homeassistant-dev kernel: hassio: port 7(vethdbc4f0d) entered blocking state
Feb 26 15:27:11 homeassistant-dev kernel: hassio: port 7(vethdbc4f0d) entered disabled state
Feb 26 15:27:11 homeassistant-dev kernel: vethdbc4f0d: entered allmulticast mode
Feb 26 15:27:11 homeassistant-dev kernel: vethdbc4f0d: entered promiscuous mode
Feb 26 15:27:11 homeassistant-dev systemd[1]: Started libcontainer container 09d6a9ad25bc90c1448bf32f762c8f9369db64ee1eb0b90d089ec7c7c631f80f.
Feb 26 15:27:11 homeassistant-dev kernel: eth0: renamed from veth063ce73
Feb 26 15:27:11 homeassistant-dev NetworkManager[386]: <info>  [1708961231.5799] device (vethdbc4f0d): carrier: link connected
Feb 26 15:27:11 homeassistant-dev kernel: hassio: port 7(vethdbc4f0d) entered blocking state
Feb 26 15:27:11 homeassistant-dev kernel: hassio: port 7(vethdbc4f0d) entered forwarding state
Feb 26 15:27:41 homeassistant-dev kernel: kauditd_printk_skb: 49 callbacks suppressed
Feb 26 15:27:41 homeassistant-dev kernel: audit: type=1334 audit(1708961261.379:230): prog-id=64 op=LOAD
Feb 26 15:27:41 homeassistant-dev kernel: audit: type=1334 audit(1708961261.380:231): prog-id=65 op=LOAD
Feb 26 15:27:41 homeassistant-dev kernel: audit: type=1334 audit(1708961261.380:232): prog-id=66 op=LOAD
Feb 26 15:27:41 homeassistant-dev systemd[1]: Starting Hostname Service...
Feb 26 15:27:41 homeassistant-dev systemd[1]: Started Hostname Service.
Feb 26 15:27:41 homeassistant-dev kernel: audit: type=1334 audit(1708961261.488:233): prog-id=67 op=LOAD
Feb 26 15:27:41 homeassistant-dev kernel: audit: type=1334 audit(1708961261.488:234): prog-id=68 op=LOAD
Feb 26 15:27:41 homeassistant-dev kernel: audit: type=1334 audit(1708961261.488:235): prog-id=69 op=LOAD
Feb 26 15:27:41 homeassistant-dev systemd[1]: Starting Time & Date Service...
Feb 26 15:27:41 homeassistant-dev systemd[1]: Started Time & Date Service.
Feb 26 15:27:52 homeassistant-dev systemd[1]: dev-virtio\x2dports-org.qemu.guest_agent.0.device: Job dev-virtio\x2dports-org.qemu.guest_agent.0.device/start timed out.
Feb 26 15:27:52 homeassistant-dev systemd[1]: Timed out waiting for device /dev/virtio-ports/org.qemu.guest_agent.0.
Feb 26 15:27:52 homeassistant-dev systemd[1]: Dependency failed for QEMU Guest Agent.
Feb 26 15:27:52 homeassistant-dev systemd[1]: qemu-guest.service: Job qemu-guest.service/start failed with result 'dependency'.
Feb 26 15:27:52 homeassistant-dev systemd[1]: dev-virtio\x2dports-org.qemu.guest_agent.0.device: Job dev-virtio\x2dports-org.qemu.guest_agent.0.device/start failed with result 'timeout'.
Feb 26 15:27:52 homeassistant-dev systemd[1]: Reached target Multi-User System.
Feb 26 15:27:52 homeassistant-dev systemd[1]: Startup finished in 472ms (kernel) + 1min 30.365s (userspace) = 1min 30.838s.
Feb 26 15:28:11 homeassistant-dev systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Feb 26 15:28:11 homeassistant-dev kernel: audit: type=1334 audit(1708961291.563:236): prog-id=66 op=UNLOAD
Feb 26 15:28:11 homeassistant-dev kernel: audit: type=1334 audit(1708961291.563:237): prog-id=65 op=UNLOAD
Feb 26 15:28:11 homeassistant-dev kernel: audit: type=1334 audit(1708961291.563:238): prog-id=64 op=UNLOAD
Feb 26 15:28:11 homeassistant-dev systemd[1]: systemd-timedated.service: Deactivated successfully.
Feb 26 15:28:11 homeassistant-dev kernel: audit: type=1334 audit(1708961291.628:239): prog-id=69 op=UNLOAD
Feb 26 15:28:11 homeassistant-dev kernel: audit: type=1334 audit(1708961291.628:240): prog-id=68 op=UNLOAD
Feb 26 15:28:11 homeassistant-dev kernel: audit: type=1334 audit(1708961291.628:241): prog-id=67 op=UNLOAD
Feb 26 15:30:17 homeassistant-dev systemd[1]: Starting Bluetooth service...
Feb 26 15:30:17 homeassistant-dev bluetoothd[3802]: Bluetooth daemon 5.72
Feb 26 15:30:17 homeassistant-dev systemd[1]: Started Bluetooth service.
Feb 26 15:30:17 homeassistant-dev bluetoothd[3802]: Starting SDP server
Feb 26 15:30:17 homeassistant-dev kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Feb 26 15:30:17 homeassistant-dev kernel: Bluetooth: BNEP filters: protocol multicast
Feb 26 15:30:17 homeassistant-dev kernel: Bluetooth: BNEP socket layer initialized
Feb 26 15:30:17 homeassistant-dev bluetoothd[3802]: Bluetooth management interface 1.22 initialized
Feb 26 15:30:17 homeassistant-dev kernel: audit: type=1334 audit(1708961417.943:242): prog-id=70 op=LOAD
Feb 26 15:30:17 homeassistant-dev kernel: audit: type=1334 audit(1708961417.943:243): prog-id=71 op=LOAD
Feb 26 15:30:17 homeassistant-dev kernel: audit: type=1334 audit(1708961417.943:244): prog-id=72 op=LOAD
Feb 26 15:30:17 homeassistant-dev systemd[1]: Starting Hostname Service...
Feb 26 15:30:18 homeassistant-dev systemd[1]: Started Hostname Service.
Feb 26 15:30:48 homeassistant-dev systemd[1]: systemd-hostnamed.service: Deactivated successfully.
Feb 26 15:30:48 homeassistant-dev kernel: audit: type=1334 audit(1708961448.106:245): prog-id=72 op=UNLOAD
Feb 26 15:30:48 homeassistant-dev kernel: audit: type=1334 audit(1708961448.106:246): prog-id=71 op=UNLOAD
Feb 26 15:30:48 homeassistant-dev kernel: audit: type=1334 audit(1708961448.106:247): prog-id=70 op=UNLOAD
Feb 26 15:33:16 homeassistant-dev kernel: audit: type=1334 audit(1708961596.227:248): prog-id=73 op=LOAD
Feb 26 15:33:16 homeassistant-dev systemd-timesyncd[1065]: Network configuration changed, trying to establish connection.
Feb 26 15:33:16 homeassistant-dev systemd[1]: Started Journal Gateway Service.
Feb 26 15:33:16 homeassistant-dev systemd-timesyncd[1065]: Contacted time server 192.168.2.1:123 (192.168.2.1).
Feb 26 15:33:16 homeassistant-dev systemd-journal-gatewayd[4020]: microhttpd: MHD_OPTION_EXTERNAL_LOGGER is not the first option specified for the daemon. Some messages may be printed by the standard MHD logger.

System information

System Information

version core-2024.2.3
installation_type Home Assistant OS
dev false
hassio true
docker true
user root
virtualenv false
python_version 3.12.1
os_name Linux
os_version 6.6.16-haos
arch x86_64
timezone Europe/Berlin
config_dir /config
Home Assistant Community Store GitHub API | ok -- | -- GitHub Content | ok GitHub Web | ok GitHub API Calls Remaining | 4949 Installed Version | 1.34.0 Stage | running Available Repositories | 1401 Downloaded Repositories | 7
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 12.0 -- | -- update_channel | beta supervisor_version | supervisor-2024.02.0 agent_version | 1.6.0 docker_version | 24.0.7 disk_total | 30.8 GB disk_used | 6.0 GB healthy | true supported | true board | ova supervisor_api | ok version_api | ok installed_addons | Advanced SSH & Web Terminal (17.1.1), Studio Code Server (5.15.0), Node-RED (17.0.7), Log Viewer (0.17.0)
Dashboards dashboards | 2 -- | -- resources | 2 views | 1 mode | storage
MercedesME 2020 api_endpoint_reachable | ok -- | -- websocket_connection_state | connected cars_connected | 1 version | v0.11.1
Recorder oldest_recorder_run | February 14, 2024 at 7:10 AM -- | -- current_recorder_run | February 26, 2024 at 4:27 PM estimated_db_size | 9.50 MiB database_engine | sqlite database_version | 3.44.2

Additional information

No response

DanDon commented 8 months ago

Same issue and my entire HA OS instance crashes out and becomes unresponsive. Full Host reboot only runs stable for a minute or two and then crashes out with:

1

maxakash commented 8 months ago

Same here, my Home Assistant is not coming online after updating

ang3lx commented 8 months ago

Same here

agners commented 8 months ago

@DanDon @maxakash @ang3lx you all get panic: "ro" shorthand is more than one ASCIII character on the console?

Are you using Hyper-V VM as well?

maxakash commented 8 months ago

@DanDon @maxakash @ang3lx you all get panic: "ro" shorthand is more than one ASCIII character on the console?

Are you using Hyper-V VM as well?

No, I am rrunning HA on Raspberry Pi 4 with sd card

ang3lx commented 8 months ago

@agners I'm out from home at this moment, so a can't see console I'm running on odroid c4

DanDon commented 8 months ago

@DanDon @maxakash @ang3lx you all get panic: "ro" shorthand is more than one ASCIII character on the console?

Are you using Hyper-V VM as well?

I'm not using Hyper-V ... I'm running the HA OS in a VM on VMware Workstation

agners commented 8 months ago

Oh I see, this is on the beta channel. This is actually not related to the OS release itself, but to the current CLI instance. The OS lead to a reboot, which started the CLI again, and ultimately printed the error.

Underlying issue is already resolved, see https://github.com/home-assistant/cli/issues/460.

I'll create an updated HA CLI plug-in release, the issue should be resolved soon.

ang3lx commented 8 months ago

sorry, it's the first time something like this has happened to me... so I'm in trouble. Is the only way to boot properly is to format or restore from backup? or is there any operation to solve the problem

schuettecarsten commented 8 months ago

Same here, also reported at https://github.com/home-assistant/core/issues/111397

maxakash commented 8 months ago

Issue resolved now. I am able to boot into HA dashboard.

atus commented 8 months ago

Same. Can't boot after update. What are the recovery steps? Is there a forward fix or do we have to reformat?

epoullet commented 8 months ago

Same for me on Raspberry. What can be done ? Only restore from backup ?

rawzone commented 8 months ago

Not sure if related but 12.0 also broke my VM (VM running under Proxmox). Just boots to EFI shell. Had to restore full VM backup to get it going again.

agners commented 8 months ago

Not sure if related but 12.0 also broke my VM (VM running under Proxmox). Just boots to EFI shell. Had to restore full VM backup to get it going again.

This is not really related.

That said, we have been reports of such issues already before, e.g. #2136. Unfortunately I was never able to reproduce this on my Proxmox setup, and we double checked all possible race conditions and make sure things are written to disk before the reboot. We even mount the boot partition "sync" mode, to make sure things hit the disk. Yet on every release (and mainly on virtual machines) we have such reports. If this is reproducible, or you have any logs/traces (maybe from the Hypervisor) which could be helpful, please open a new issue with the details.

agners commented 8 months ago

Same for me on Raspberry. What can be done ? Only restore from backup ?

Your Home Assistant installation should remain working. You'll get the new CLI update 2024.02.1 within the next few hours. From then on the CLI will work normally again as well.

derolli1976 commented 8 months ago

Same for me on Raspberry. What can be done ? Only restore from backup ?

Your Home Assistant installation should remain working. You'll get the new CLI update 2024.02.1 within the next few hours. From then on the CLI will work normally again as well.

New version fixes the issue for me. CLI is working again. At least for me, HA webclient has been available all the time.

atus commented 8 months ago

Your Home Assistant installation should remain working. You'll get the new CLI update 2024.02.1 within the next few hours. From then on the CLI will work normally again as well.

Left it running 4-5 hours after your comment and tried a couple restarts. There is 0 activity on network and it never even gets an ip. image I had to reinstall everything. Luckily I had a recebt backup so I lost about 36h of data.

What process is in place to catch something like this next time? Why don't we require a backup before an os install?

agners commented 8 months ago

The main issue here, panic: "ro" shorthand is more than one ASCIII character on the system console, is resolved by the latest CLI update, as confirmed by @derolli1976 . I am closing the issue.

@nicolazilio @atus your issues are not related to this issue really. Please open a new issue along with all required information.