home-assistant / supervisor

:house_with_garden: Home Assistant Supervisor
https://home-assistant.io/hassio/
Apache License 2.0
1.75k stars 640 forks source link

Update Operating System to version null #2256

Closed phaked closed 3 years ago

phaked commented 3 years ago

Describe the issue

I installed HassOS on a virtual machine using the qcow2 image from https://www.home-assistant.io/hassio/installation/. I've provided the supervisor log which is available after the initial boot since I've already spotted an error message.

After the installation the supervisor dashboard shows an available update for the Operating System. Clicking on the enabled update button yields the following message: Are you sure you want to update Operating System to version null?

Confirming the update clicking on the update button results in the error message: Unknown error, see supervisor. I've also provided the additional log entries after the described update procedure.

Similar behavior is also reported here: https://community.home-assistant.io/t/update-operating-system-to-version-null/241629

Steps to reproduce

  1. Install a VM using virt-install --virt-type=kvm --name homeassistant --memory 2048 --vcpus=1 --os-variant=generic --network=bridge=br0,model=virtio --graphics none --disk path=/var/lib/libvirt/images/hassos_ova-4.16.qcow2 --import --boot uefi
  2. Go to http://xxx.xxx.xxx.xxx:8123/hassio/dashboard
  3. Click on the update button for the OS.
  4. Again, click on update.

Enviroment details

Supervisor logs

Supervisor logs Log after first boot: ``` [s6-init] making user provided files available at /var/run/s6/etc...exited 0. [s6-init] ensuring user provided files have correct perms...exited 0. [fix-attrs.d] applying ownership & permissions fixes... [fix-attrs.d] done. [cont-init.d] executing container initialization scripts... [cont-init.d] udev.sh: executing... [12:08:04] INFO: Update udev information [cont-init.d] udev.sh: exited 0. [cont-init.d] done. [services.d] starting services [services.d] done. [12:08:05] INFO: Starting local supervisor watchdog... 20-11-14 12:08:05 INFO (MainThread) [__main__] Initializing Supervisor setup 20-11-14 12:08:05 INFO (MainThread) [supervisor.docker.network] Can't find Supervisor network, creating a new network 20-11-14 12:08:05 INFO (MainThread) [supervisor.bootstrap] Initializing Supervisor Sentry 20-11-14 12:08:05 INFO (MainThread) [supervisor.bootstrap] Creating Supervisor Add-on data folder at '/data/addons/data' 20-11-14 12:08:08 INFO (SyncWorker_0) [supervisor.docker.supervisor] Attaching to Supervisor homeassistant/amd64-hassio-supervisor with version 2020.11.0 20-11-14 12:08:08 INFO (SyncWorker_0) [supervisor.docker.supervisor] Connecting Supervisor to hassio-network 20-11-14 12:08:08 INFO (MainThread) [__main__] Setting up Supervisor 20-11-14 12:08:08 INFO (MainThread) [supervisor.api] Starting API on 172.30.32.2 20-11-14 12:08:08 INFO (MainThread) [supervisor.host.info] Updating local host information 20-11-14 12:08:08 INFO (MainThread) [supervisor.host.services] Updating service information 20-11-14 12:08:08 INFO (MainThread) [supervisor.host.network] Updating local network information 20-11-14 12:08:08 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information 20-11-14 12:08:08 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'} 20-11-14 12:08:08 INFO (MainThread) [supervisor.host.services] Reloading local service hassos-apparmor.service 20-11-14 12:08:08 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-dns with version 2020.11.0 20-11-14 12:08:08 INFO (MainThread) [supervisor.plugins.dns] Starting CoreDNS plugin 20-11-14 12:08:09 INFO (SyncWorker_1) [supervisor.docker.dns] Starting DNS homeassistant/amd64-hassio-dns with version 2020.11.0 - 172.30.32.3 20-11-14 12:08:09 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf 20-11-14 12:08:09 INFO (SyncWorker_1) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-audio with version 17 20-11-14 12:08:09 INFO (MainThread) [supervisor.plugins.audio] Starting Audio plugin 20-11-14 12:08:09 INFO (SyncWorker_0) [supervisor.docker.audio] Starting Audio homeassistant/amd64-hassio-audio with version 17 - 172.30.32.4 20-11-14 12:08:09 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-cli with version 2020.10.1 20-11-14 12:08:09 INFO (MainThread) [supervisor.plugins.cli] Starting CLI plugin 20-11-14 12:08:10 INFO (SyncWorker_1) [supervisor.docker.cli] Starting CLI homeassistant/amd64-hassio-cli with version 2020.10.1 - 172.30.32.5 20-11-14 12:08:10 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-observer with version 2020.10.1 20-11-14 12:08:10 INFO (MainThread) [supervisor.plugins.observer] Starting observer plugin 20-11-14 12:08:11 INFO (SyncWorker_2) [supervisor.docker.observer] Starting Observer homeassistant/amd64-hassio-observer with version 2020.10.1 - 172.30.32.6 20-11-14 12:08:11 INFO (SyncWorker_0) [supervisor.docker.interface] Attaching to homeassistant/amd64-hassio-multicast with version 3 20-11-14 12:08:11 INFO (MainThread) [supervisor.plugins.multicast] Starting Multicast plugin 20-11-14 12:08:11 INFO (SyncWorker_1) [supervisor.docker.multicast] Starting Multicast homeassistant/amd64-hassio-multicast with version 3 - Host 20-11-14 12:08:11 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json 20-11-14 12:08:11 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 0 Home Assistant secrets 20-11-14 12:08:11 INFO (SyncWorker_2) [supervisor.docker.interface] Attaching to homeassistant/qemux86-64-homeassistant with version landingpage 20-11-14 12:08:11 INFO (MainThread) [supervisor.homeassistant.core] Starting HomeAssistant landingpage 20-11-14 12:08:11 INFO (MainThread) [supervisor.homeassistant] Update pulse/client.config: /data/tmp/homeassistant_pulse 20-11-14 12:08:11 INFO (SyncWorker_0) [supervisor.docker.homeassistant] Starting Home Assistant homeassistant/qemux86-64-homeassistant with version landingpage 20-11-14 12:08:11 INFO (MainThread) [supervisor.hassos] Detect HassOS 4.16 / BootSlot A 20-11-14 12:08:11 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/home-assistant/hassio-addons repository 20-11-14 12:08:11 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/hassio-addons/repository repository 20-11-14 12:08:13 INFO (MainThread) [supervisor.store] Loading add-ons from store: 66 all - 66 new - 0 remove 20-11-14 12:08:13 INFO (MainThread) [supervisor.addons] Found 0 installed add-ons 20-11-14 12:08:13 INFO (MainThread) [supervisor.snapshots] Found 0 snapshot files 20-11-14 12:08:13 INFO (MainThread) [supervisor.discovery] Loaded 0 messages 20-11-14 12:08:13 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions 20-11-14 12:08:13 INFO (MainThread) [__main__] Running Supervisor 20-11-14 12:08:13 INFO (MainThread) [supervisor.hassos] Rauc: A - marked slot kernel.0 as good 20-11-14 12:08:13 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.INITIALIZE' starting 0 add-ons 20-11-14 12:08:13 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SYSTEM' starting 0 add-ons 20-11-14 12:08:13 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.SERVICES' starting 0 add-ons 20-11-14 12:08:13 INFO (MainThread) [supervisor.addons] Phase 'AddonStartup.APPLICATION' starting 0 add-ons 20-11-14 12:08:14 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled 20-11-14 12:08:14 INFO (MainThread) [supervisor.misc.hwmon] Started Supervisor hardware monitor 20-11-14 12:08:14 INFO (MainThread) [supervisor.core] Supervisor is up and running 20-11-14 12:08:14 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant setup 20-11-14 12:08:14 INFO (MainThread) [supervisor.host.info] Updating local host information 20-11-14 12:08:14 INFO (SyncWorker_0) [supervisor.docker.interface] Updating image homeassistant/qemux86-64-homeassistant:landingpage to homeassistant/qemux86-64-homeassistant:0.117.6 20-11-14 12:08:14 INFO (SyncWorker_0) [supervisor.docker.interface] Downloading docker image homeassistant/qemux86-64-homeassistant with tag 0.117.6. 20-11-14 12:08:14 ERROR (SyncWorker_0) [supervisor.docker.interface] Can't install homeassistant/qemux86-64-homeassistant:0.117.6 -> 500 Server Error: Internal Server Error ("Get https://registry-1.docker.io/v2/: dial tcp: lookup registry-1.docker.io on [::1]:53: read udp [::1]:42267->[::1]:53: read: connection refused"). 20-11-14 12:08:14 WARNING (MainThread) [supervisor.homeassistant.core] Error on Home Assistant installation. Retry in 30sec 20-11-14 12:08:14 INFO (MainThread) [supervisor.host.services] Updating service information 20-11-14 12:08:14 INFO (MainThread) [supervisor.host.network] Updating local network information 20-11-14 12:08:44 INFO (SyncWorker_0) [supervisor.docker.interface] Updating image homeassistant/qemux86-64-homeassistant:landingpage to homeassistant/qemux86-64-homeassistant:0.117.6 20-11-14 12:08:44 INFO (SyncWorker_0) [supervisor.docker.interface] Downloading docker image homeassistant/qemux86-64-homeassistant with tag 0.117.6. 20-11-14 12:09:48 INFO (SyncWorker_0) [supervisor.docker.interface] Stopping homeassistant application 20-11-14 12:09:52 INFO (SyncWorker_0) [supervisor.docker.interface] Cleaning homeassistant application 20-11-14 12:09:52 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant docker now installed 20-11-14 12:09:52 INFO (MainThread) [supervisor.homeassistant.core] Starting Home Assistant 20-11-14 12:09:52 INFO (MainThread) [supervisor.homeassistant] Update pulse/client.config: /data/tmp/homeassistant_pulse 20-11-14 12:09:53 INFO (SyncWorker_2) [supervisor.docker.homeassistant] Starting Home Assistant homeassistant/qemux86-64-homeassistant with version 0.117.6 20-11-14 12:09:53 INFO (MainThread) [supervisor.homeassistant.core] Wait until Home Assistant is ready 20-11-14 12:09:58 INFO (MainThread) [supervisor.homeassistant.api] Updated Home Assistant API token 20-11-14 12:09:58 INFO (MainThread) [supervisor.homeassistant.core] Detect a running Home Assistant instance 20-11-14 12:09:58 INFO (SyncWorker_2) [supervisor.docker.interface] Cleanup images: ['homeassistant/qemux86-64-homeassistant:landingpage'] ``` Log after clickling the update button: ``` 20-11-14 12:19:40 INFO (MainThread) [supervisor.snapshots] Found 0 snapshot files 20-11-14 12:29:24 INFO (MainThread) [supervisor.hassos] Fetch OTA update from https://github.com/home-assistant/operating-system/releases/download/None/hassos_ova-None.raucb ```
ludeeus commented 3 years ago

This was fixed in https://github.com/home-assistant/supervisor/pull/2244 and will be a part of the next Supervisor release.