Installation stuck on "Preparing Home Assistant" screen

zerkruemler · April 27, 2024, 4:56pm

Hello,
I am trying to install HA to my new Raspberry PI5 using this guide:

The “Preparing Home Assistant” screen does not get further even after hours.

I tried the Raspberry Pi Imager and the Balena Etcher method with the 12.2 image
I used a 128GB Sandisk and a 64GB Lexar SD card
I have a monitor and keyboard plugged in, but there are no errors on the screen. There are also no errors in the log of the webpage.
http://homeassistant:4357/ says:
|Supervisor:|Connected|
|Supported:|Supported|
|Healthy:|Healthy|

What can I do to find out what is going on? I have Homeassistant running on a Raspberry PI 3, but it has not enough power memory to run influx and grafana smoothly. I disconnected this one so I does not conflict with my new PI 5.

Thanks

This is the log:

s6-rc: info: service s6rc-oneshot-runner: starting
s6-rc: info: service s6rc-oneshot-runner successfully started
s6-rc: info: service fix-attrs: starting
s6-rc: info: service fix-attrs successfully started
s6-rc: info: service legacy-cont-init: starting
cont-init: info: running /etc/cont-init.d/udev.sh
INFO: Using udev information from host
cont-init: info: /etc/cont-init.d/udev.sh exited 0
s6-rc: info: service legacy-cont-init successfully started
s6-rc: info: service legacy-services: starting
services-up: info: copying legacy longrun supervisor (no readiness notification)
services-up: info: copying legacy longrun watchdog (no readiness notification)
INFO: Starting local supervisor watchdog...
s6-rc: info: service legacy-services successfully started
.713 INFO (MainThread) [__main__] Initializing Supervisor setup
.724 INFO (MainThread) [supervisor.docker.network] Can't find Supervisor network, creating a new network
.896 INFO (MainThread) [supervisor.bootstrap] Setting up coresys for machine: raspberrypi5-64
.900 INFO (MainThread) [supervisor.docker.supervisor] Attaching to Supervisor ghcr.io/home-assistant/aarch64-hassio-supervisor with version 2024.04.0
.901 INFO (MainThread) [supervisor.docker.supervisor] Connecting Supervisor to hassio-network
.038 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state initialize
.040 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
.041 INFO (MainThread) [__main__] Setting up Supervisor
.197 INFO (MainThread) [supervisor.api] Starting API on 172.30.32.2
.240 INFO (MainThread) [supervisor.hardware.monitor] Started Supervisor hardware monitor
.243 INFO (MainThread) [supervisor.dbus.manager] Connected to system D-Bus.
.243 INFO (MainThread) [supervisor.dbus.agent] Load dbus interface io.hass.os
.244 INFO (MainThread) [supervisor.dbus.hostname] Load dbus interface org.freedesktop.hostname1
.244 INFO (MainThread) [supervisor.dbus.logind] Load dbus interface org.freedesktop.login1
.244 INFO (MainThread) [supervisor.dbus.network] Load dbus interface org.freedesktop.NetworkManager
.245 INFO (MainThread) [supervisor.dbus.rauc] Load dbus interface de.pengutronix.rauc
.245 INFO (MainThread) [supervisor.dbus.resolved] Load dbus interface org.freedesktop.resolve1
.246 INFO (MainThread) [supervisor.dbus.systemd] Load dbus interface org.freedesktop.systemd1
.247 INFO (MainThread) [supervisor.dbus.timedate] Load dbus interface org.freedesktop.timedate1
.370 INFO (MainThread) [supervisor.host.services] Updating service information
.373 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
.378 WARNING (SyncWorker_0) [supervisor.host.sound] Can't update PulseAudio data: Failed to connect to pulseaudio server
.534 INFO (MainThread) [supervisor.host.network] Updating local network information
.634 INFO (MainThread) [supervisor.host.apparmor] Loading AppArmor Profiles: {'hassio-supervisor'}
.810 INFO (MainThread) [supervisor.docker.monitor] Started docker events monitor
.811 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json
.935 INFO (MainThread) [supervisor.docker.interface] Found ghcr.io/home-assistant/aarch64-hassio-cli versions: []
.940 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/aarch64-hassio-cli with version 2024.04.0
.960 INFO (MainThread) [supervisor.plugins.cli] Starting CLI plugin
.547 INFO (MainThread) [supervisor.docker.cli] Starting CLI ghcr.io/home-assistant/aarch64-hassio-cli with version 2024.04.0 - 172.30.32.5
.572 INFO (MainThread) [supervisor.docker.interface] Found ghcr.io/home-assistant/aarch64-hassio-dns versions: []
.577 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/aarch64-hassio-dns with version 2024.04.0
.616 INFO (MainThread) [supervisor.plugins.dns] Starting CoreDNS plugin
.416 INFO (MainThread) [supervisor.docker.dns] Starting DNS ghcr.io/home-assistant/aarch64-hassio-dns with version 2024.04.0 - 172.30.32.3
.418 INFO (MainThread) [supervisor.plugins.dns] Updated /etc/resolv.conf
.442 INFO (MainThread) [supervisor.docker.interface] Found ghcr.io/home-assistant/aarch64-hassio-audio versions: []
.447 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/aarch64-hassio-audio with version 2023.12.0
.465 INFO (MainThread) [supervisor.plugins.audio] Starting Audio plugin
.287 INFO (MainThread) [supervisor.docker.audio] Starting Audio ghcr.io/home-assistant/aarch64-hassio-audio with version 2023.12.0 - 172.30.32.4
.299 INFO (MainThread) [supervisor.docker.interface] Found ghcr.io/home-assistant/aarch64-hassio-observer versions: []
.305 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/aarch64-hassio-observer with version 2023.06.0
.337 INFO (MainThread) [supervisor.plugins.observer] Starting observer plugin
.084 INFO (MainThread) [supervisor.docker.observer] Starting Observer ghcr.io/home-assistant/aarch64-hassio-observer with version 2023.06.0 - 172.30.32.6
.104 INFO (MainThread) [supervisor.docker.interface] Found ghcr.io/home-assistant/aarch64-hassio-multicast versions: []
.111 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/aarch64-hassio-multicast with version 2024.03.0
.144 INFO (MainThread) [supervisor.plugins.multicast] Starting Multicast plugin
.826 INFO (MainThread) [supervisor.docker.multicast] Starting Multicast ghcr.io/home-assistant/aarch64-hassio-multicast with version 2024.03.0 - Host
.827 INFO (MainThread) [supervisor.homeassistant.secrets] Loaded 0 Home Assistant secrets
.839 INFO (MainThread) [supervisor.docker.interface] No version found for ghcr.io/home-assistant/raspberrypi5-64-homeassistant
.840 INFO (MainThread) [supervisor.homeassistant.core] No Home Assistant Docker image ghcr.io/home-assistant/raspberrypi5-64-homeassistant found.
.846 INFO (MainThread) [supervisor.docker.interface] Attaching to ghcr.io/home-assistant/raspberrypi5-64-homeassistant with version landingpage
.846 INFO (MainThread) [supervisor.homeassistant.core] Using preinstalled landingpage
.864 INFO (MainThread) [supervisor.homeassistant.core] Starting HomeAssistant landingpage
.888 INFO (MainThread) [supervisor.homeassistant.module] Update pulse/client.config: /data/tmp/homeassistant_pulse
.447 INFO (MainThread) [supervisor.docker.homeassistant] Starting Home Assistant ghcr.io/home-assistant/raspberrypi5-64-homeassistant with version landingpage
.500 INFO (MainThread) [supervisor.os.manager] Detect Home Assistant Operating System 12.2 / BootSlot A
.503 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/esphome/home-assistant-addon repository
.505 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/home-assistant/addons repository
.507 INFO (MainThread) [supervisor.store.git] Cloning add-on https://github.com/hassio-addons/repository repository
.909 INFO (MainThread) [supervisor.store] Loading add-ons from store: 77 all - 77 new - 0 remove
.924 INFO (MainThread) [supervisor.addons.manager] Found 0 installed add-ons
.938 INFO (MainThread) [supervisor.backups.manager] Found 0 backup files
.938 INFO (MainThread) [supervisor.discovery] Loaded 0 messages
.938 INFO (MainThread) [supervisor.ingress] Loaded 0 ingress sessions
.938 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state setup
.938 INFO (MainThread) [supervisor.resolution.check] System checks complete
.938 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
.939 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
.939 INFO (MainThread) [supervisor.jobs] 'ResolutionFixup.run_autofix' blocked from execution, system is not running - setup
.939 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state setup
.939 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
.940 INFO (MainThread) [__main__] Running Supervisor
.951 INFO (MainThread) [supervisor.os.manager] Rauc: A - marked slot kernel.0 as good
.957 INFO (MainThread) [supervisor.addons.manager] Phase 'initialize' starting 0 add-ons
.009 INFO (MainThread) [supervisor.addons.manager] Phase 'system' starting 0 add-ons
.010 INFO (MainThread) [supervisor.addons.manager] Phase 'services' starting 0 add-ons
.013 INFO (MainThread) [supervisor.core] Skipping start of Home Assistant
.013 INFO (MainThread) [supervisor.addons.manager] Phase 'application' starting 0 add-ons
.023 INFO (MainThread) [supervisor.misc.tasks] All core tasks are scheduled
.024 INFO (MainThread) [supervisor.core] Supervisor is up and running
.024 INFO (MainThread) [supervisor.homeassistant.core] Home Assistant setup
.025 INFO (MainThread) [supervisor.docker.interface] Updating image ghcr.io/home-assistant/raspberrypi5-64-homeassistant:landingpage to ghcr.io/home-assistant/raspberrypi5-64-homeassistant:2024.4.4
.025 INFO (MainThread) [supervisor.docker.interface] Downloading docker image ghcr.io/home-assistant/raspberrypi5-64-homeassistant with tag 2024.4.4.
.025 INFO (MainThread) [supervisor.host.info] Updating local host information
.028 INFO (MainThread) [supervisor.updater] Fetching update data from https://version.home-assistant.io/stable.json
.029 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state running
.029 INFO (MainThread) [supervisor.resolution.checks.base] Run check for trust/supervisor
.038 INFO (MainThread) [supervisor.resolution.checks.base] Run check for ipv4_connection_problem/system
.038 INFO (MainThread) [supervisor.resolution.checks.base] Run check for multiple_data_disks/system
.038 INFO (MainThread) [supervisor.resolution.checks.base] Run check for docker_config/system
.038 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_ipv6_error/dns_server
.060 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_failed/dns_server
.081 INFO (MainThread) [supervisor.resolution.checks.base] Run check for pwned/addon
.081 INFO (MainThread) [supervisor.resolution.checks.base] Run check for no_current_backup/system
.082 INFO (MainThread) [supervisor.resolution.module] Create new suggestion create_full_backup - system / None
.082 INFO (MainThread) [supervisor.resolution.module] Create new issue no_current_backup - system / None
.082 INFO (MainThread) [supervisor.resolution.checks.base] Run check for security/core
.082 INFO (MainThread) [supervisor.resolution.checks.base] Run check for free_space/system
.083 INFO (MainThread) [supervisor.resolution.check] System checks complete
.083 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state running
.272 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
.272 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state running
.273 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete
.288 INFO (MainThread) [supervisor.host.services] Updating service information
.293 INFO (MainThread) [supervisor.host.network] Updating local network information
.365 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
.369 INFO (MainThread) [supervisor.host.manager] Host information reload completed
HIDE DETAILS
Read our vision
Join our community

francisp · April 27, 2024, 5:01pm

Did you try http://ip:8123 with the ip shown on that screen ?

afbeelding

zerkruemler · April 27, 2024, 5:32pm

Just another half an hour later and it works!
It is a little bit misleading that the screen says it can be up to 20 minutes and it takes then more than 2 hours on the newest available Raspberry PI. I remember it was much faster on my PI 3.
Nevertheless, thanks for the help, it works now.

FloatingBoater · April 27, 2024, 5:37pm

Hi,
It does look like the install was successful.

Some installs “stall” with connectivity/ DNS/ bandwidth issues when the latest HASS image is downloaded, but not here:

.025 INFO (MainThread) [supervisor.docker.interface] Downloading docker image ghcr.io/home-assistant/raspberrypi5-64-homeassistant with tag 2024.4.4.

I’d agree with Francisp’s inference - try connecting via the IPv4 on the screen (IPv6 would work, but save yourself the typing!).

My guess is something on your client / LAN is caching the RPi3 IPv4 and going to the old mDNS entry. Android can resolved mDNS differently from Win10 so try different client OS and browsers.

What’s odd is that you can connect to the observer on http://homeassistant:4357/ - I’d expect the same client/ browser to work with http://homeassistant:8123/ as it’s all just HTTP/IP.

The next option would be to try SSH’ing in (mDNS, IPv4, IPv6), try unplug/plug the LAN RJ45 (can force DHCP/ DNS) and them try a hard reboot - not ideal but might kick something.

PS Thanks for the excellent report - detailed, formatted, and relevant.

Whilst I’m here, here a few tips that might help…

The RPi3a is no longer supported as the memory is too small, and the RPi3b struggles with more than a couple of integrations - still might be useful as a test platform, or a proxy though.
The RPi4 is significantly faster, especially when paired with a decent uSD or external USB3.0 NVMe SSD in caddy. 2Mb of memory is plenty unless you’re in a complex mansion.
Install any USB radios in the not blue USB2.0 ports, and ideally use an extension cable - this can make a different due to USB3.0 RF noise.
I’ve not tried a RPi5 with HASSOS, but comparing general desktop use, it’s going to fly through stuff like ESPhome compiles.)

zerkruemler · April 28, 2024, 7:42am

After Installation I recognized that the processor gets quite hot. So I added a heatsink and active cooling, maybe my long installation time is due to overheating.
I used a new SD card and tried the installation again.

The installation took 1:50 hours.

Especially after the places marked in the log below there where long pauses of half an hour and an hour

I wonder if my raspberry is defective. But the installation works fine up to now. I have installed influx db and grafana and everything runs fine.

.521 INFO (MainThread) [supervisor.host.sound] Updating PulseAudio information
.525 INFO (MainThread) [supervisor.host.manager] Host information reload completed

<<< Long pause >>>

.197 INFO (MainThread) [supervisor.resolution.check] Starting system checks with state running
.197 INFO (MainThread) [supervisor.resolution.checks.base] Run check for ipv4_connection_problem/system
.197 INFO (MainThread) [supervisor.resolution.checks.base] Run check for pwned/addon
.314 INFO (MainThread) [supervisor.resolution.checks.base] Run check for security/core
.314 INFO (MainThread) [supervisor.resolution.checks.base] Run check for multiple_data_disks/system
.315 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_failed/dns_server
.315 INFO (MainThread) [supervisor.resolution.checks.base] Run check for dns_server_ipv6_error/dns_server
.315 INFO (MainThread) [supervisor.resolution.checks.base] Run check for trust/supervisor
.320 INFO (MainThread) [supervisor.resolution.checks.base] Run check for free_space/system
.320 INFO (MainThread) [supervisor.resolution.checks.base] Run check for docker_config/system
.320 INFO (MainThread) [supervisor.resolution.check] System checks complete
.320 INFO (MainThread) [supervisor.resolution.evaluate] Starting system evaluation with state running
.373 INFO (MainThread) [supervisor.resolution.evaluate] System evaluation complete
.373 INFO (MainThread) [supervisor.resolution.fixup] Starting system autofix at state running
.373 INFO (MainThread) [supervisor.resolution.fixup] System autofix complete

<<< Very long pause >>>