Hello,
I’m hoping someone can help me figure out how to debug this further, as having the machine restart every 2 minutes makes it pretty impossible to investigate.
I have installed Home Assistant Supervisor using the supervised-installer script on a Pine A64 board. Specifically, I ran the following command curl -sL https://raw.githubusercontent.com/home-assistant/hassio-build/master/install/hassio_install 75 | bash -s – -m qemuarm-64
After the installation, my PineA64 board started rebooting every few minutes. Eventually by starting the hassio-supervisor service while tailing syslog, I was able to capture the following output:
Apr 29 19:20:11 pine64 93c10cef80f3[1684]: #033[32m21-04-29 11:20:11 INFO (SyncWorker_1) [supervisor.docker.interface] No version found for homeassistant/aarch64-hassio-cli#033[0m
Apr 29 19:20:11 pine64 hassio-supervisor[3653]: #033[32m21-04-29 11:20:11 INFO (SyncWorker_1) [supervisor.docker.interface] No version found for homeassistant/aarch64-hassio-cli#033[0m
Apr 29 19:20:11 pine64 93c10cef80f3[1684]: #033[32m21-04-29 11:20:11 INFO (MainThread) [supervisor.plugins.cli] No cli plugin Docker image homeassistant/aarch64-hassio-cli found.#033[0m
Apr 29 19:20:11 pine64 hassio-supervisor[3653]: #033[32m21-04-29 11:20:11 INFO (MainThread) [supervisor.plugins.cli] No cli plugin Docker image homeassistant/aarch64-hassio-cli found.#033[0m
Apr 29 19:20:11 pine64 93c10cef80f3[1684]: #033[32m21-04-29 11:20:11 INFO (MainThread) [supervisor.plugins.cli] Running setup for CLI plugin#033[0m
Apr 29 19:20:11 pine64 hassio-supervisor[3653]: #033[32m21-04-29 11:20:11 INFO (MainThread) [supervisor.plugins.cli] Running setup for CLI plugin#033[0m
Apr 29 19:20:11 pine64 93c10cef80f3[1684]: #033[32m21-04-29 11:20:11 INFO (SyncWorker_0) [supervisor.docker.interface] Downloading docker image homeassistant/aarch64-hassio-cli with tag 2021.03.1.#033[0m
Apr 29 19:20:11 pine64 hassio-supervisor[3653]: #033[32m21-04-29 11:20:11 INFO (SyncWorker_0) [supervisor.docker.interface] Downloading docker image homeassistant/aarch64-hassio-cli with tag 2021.03.1.#033[0m
Apr 29 19:20:11 pine64 59b989a3af35[1684]: [s6-init] making user provided files available at /var/run/s6/etc...exited 0.
Apr 29 19:20:11 pine64 59b989a3af35[1684]: [s6-init] ensuring user provided files have correct perms...exited 0.
Apr 29 19:20:12 pine64 59b989a3af35[1684]: [fix-attrs.d] applying ownership & permissions fixes...
Apr 29 19:20:12 pine64 59b989a3af35[1684]: [fix-attrs.d] scripts: applying...
Apr 29 19:20:12 pine64 59b989a3af35[1684]: [fix-attrs.d] scripts: exited 0.
Apr 29 19:20:12 pine64 59b989a3af35[1684]: [fix-attrs.d] done.
Apr 29 19:20:12 pine64 59b989a3af35[1684]: [cont-init.d] executing container initialization scripts...
Apr 29 19:20:12 pine64 59b989a3af35[1684]: [cont-init.d] alsa-mixer.sh: executing...
Apr 29 19:20:12 pine64 avahi-daemon[1354]: Joining mDNS multicast group on interface veth8ebfa3d.IPv6 with address fe80::c8f5:caff:fe9a:2387.
Apr 29 19:20:12 pine64 avahi-daemon[1354]: New relevant interface veth8ebfa3d.IPv6 for mDNS.
Apr 29 19:20:12 pine64 avahi-daemon[1354]: Registering new address record for fe80::c8f5:caff:fe9a:2387 on veth8ebfa3d.*.
Apr 29 19:20:12 pine64 59b989a3af35[1684]: [19:20:12] INFO: #033[32mAdjust ALSA mixer settings for /dev/snd/controlC0#033[0m
Apr 29 19:20:15 pine64 59b989a3af35[1684]: [19:20:15] INFO: #033[32mAdjust ALSA mixer settings for /dev/snd/controlC1#033[0m
Apr 29 19:20:17 pine64 dockerd[1684]: time="2021-04-29T19:20:17.270064490+08:00" level=error msg="Handler for GET /v1.41/images/homeassistant/aarch64-hassio-cli:2021.03.1/json returned error: readlink /var/lib/docker/overlay2: invalid argument"
Apr 29 19:20:17 pine64 93c10cef80f3[1684]: #033[31m21-04-29 11:20:17 ERROR (SyncWorker_0) [supervisor.docker.interface] Can't install homeassistant/aarch64-hassio-cli:2021.03.1 -> 500 Server Error for http+docker://localhost/v1.41/images/homeassistant/aarch64-hassio-cli:2021.03.1/json: Internal Server Error ("readlink /var/lib/docker/overlay2: invalid argument").#033[0m
Apr 29 19:20:17 pine64 hassio-supervisor[3653]: #033[31m21-04-29 11:20:17 ERROR (SyncWorker_0) [supervisor.docker.interface] Can't install homeassistant/aarch64-hassio-cli:2021.03.1 -> 500 Server Error for http+docker://localhost/v1.41/images/homeassistant/aarch64-hassio-cli:2021.03.1/json: Internal Server Error ("readlink /var/lib/docker/overlay2: invalid argument").#033[0m
Apr 29 19:20:17 pine64 93c10cef80f3[1684]: #033[33m21-04-29 11:20:17 WARNING (MainThread) [supervisor.plugins.cli] Error on install cli plugin. Retry in 30sec#033[0m
Apr 29 19:20:17 pine64 hassio-supervisor[3653]: #033[33m21-04-29 11:20:17 WARNING (MainThread) [supervisor.plugins.cli] Error on install cli plugin. Retry in 30sec#033[0m
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [cont-init.d] alsa-mixer.sh: exited 0.
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [cont-init.d] filesystem.sh: executing...
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [cont-init.d] filesystem.sh: exited 0.
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [cont-init.d] pulse-config.sh: executing...
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [cont-init.d] pulse-config.sh: exited 0.
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [cont-init.d] done.
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [services.d] starting services
Apr 29 19:20:18 pine64 59b989a3af35[1684]: [services.d] done.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: W: [pulseaudio] main.c: Running in system mode, but --disallow-module-loading not set.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] core-rtclock.c: Timer slack is set to 50 us.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] core-util.c: setpriority() worked.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] core-util.c: Successfully gained nice level -11.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Found user 'root' (UID 0) and group 'root' (GID 0).
Apr 29 19:20:19 pine64 59b989a3af35[1684]: W: [pulseaudio] main.c: Home directory of user 'root' is not '/var/run/pulse', ignoring.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: W: [pulseaudio] caps.c: Normally all extra capabilities would be dropped now, but that's impossible because PulseAudio was built without capabilities support.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Successfully changed user to "root".
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: This is PulseAudio 14.2
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Compilation CFLAGS: Not yet supported on meson
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Running on host: Linux aarch64 5.10.21-sunxi64 #21.02.3 SMP Mon Mar 8 00:45:13 UTC 2021
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Found 4 CPUs.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Page size is 4096 bytes
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Compiled with Valgrind support: no
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Running in valgrind mode: no
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Running in VM: no
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Running from build tree: no
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: Optimized build: yes
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] main.c: All asserts enabled.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Machine ID is 25f3942c18884f46bd8ed710d6b0edb4.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Using runtime directory /var/run/pulse.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Using state directory /data/states.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Using modules directory /usr/lib/pulse-14.2/modules.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: Running in system mode: yes
Apr 29 19:20:19 pine64 59b989a3af35[1684]: W: [pulseaudio] main.c: OK, so you are running PA in system mode. Please make sure that you actually do want to do that.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: W: [pulseaudio] main.c: Please read http://www.freedesktop.org/wiki/Software/PulseAudio/Documentation/User/WhatIsWrongWithSystemWide/ for an explanation why system mode is usually a bad idea.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] main.c: System supports high resolution timers
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] memblock.c: Using private memory pool with 1024 slots of size 64.0 KiB each, total size is 64.0 MiB, maximum usable slot size is 65472
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] database-tdb.c: Opened TDB database '/data/states/25f3942c18884f46bd8ed710d6b0edb4-device-volumes.tdb'
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] database.c: Successfully opened 'device-volumes' database file '/data/states/25f3942c18884f46bd8ed710d6b0edb4-device-volumes.tdb'.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] module.c: Loaded "module-device-restore" (index: #0; argument: "").
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] database-tdb.c: Opened TDB database '/data/states/25f3942c18884f46bd8ed710d6b0edb4-stream-volumes.tdb'
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] database.c: Successfully opened 'stream-volumes' database file '/data/states/25f3942c18884f46bd8ed710d6b0edb4-stream-volumes.tdb'.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] protocol-dbus.c: Interface org.PulseAudio.Ext.StreamRestore1 added for object /org/pulseaudio/stream_restore1
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] module.c: Loaded "module-stream-restore" (index: #1; argument: "").
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] database-tdb.c: Opened TDB database '/data/states/25f3942c18884f46bd8ed710d6b0edb4-card-database.tdb'
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] database.c: Successfully opened 'card-database' database file '/data/states/25f3942c18884f46bd8ed710d6b0edb4-card-database.tdb'.
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] module.c: Loaded "module-card-restore" (index: #2; argument: "").
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] module.c: Loaded "module-switch-on-port-available" (index: #3; argument: "").
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] module.c: Loaded "module-switch-on-connect" (index: #4; argument: "").
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] module-udev-detect.c: /dev/snd/controlC1 is accessible: yes
Apr 29 19:20:19 pine64 59b989a3af35[1684]: W: [pulseaudio] module-udev-detect.c: Failed to open /proc/asound/card1: No such file or directory
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] module-udev-detect.c: /devices/platform/hdmi-sound/sound/card1 is busy: no
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] module-udev-detect.c: Loading module-alsa-card with arguments 'device_id="1" name="platform-hdmi-sound" card_name="alsa_card.platform-hdmi-sound" namereg_fail=false tsched=yes fixed_latency_range=no ignore_dB=no deferred_volume=yes use_ucm=yes avoid_resampling=no card_properties="module-udev-detect.discovered=1"'
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] (alsa-lib)main.c: error: failed to import hw:1 use case configuration -2
Apr 29 19:20:19 pine64 59b989a3af35[1684]: I: [pulseaudio] (alsa-lib)main.c: error: failed to import sun50i-a64-hdmi use case configuration -2
[SNIP FOR FORUM POST LENGTH]
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:iec958-dts-surround-51+input:stereo-fallback - will not be able to open output:iec958-dts-surround-51
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:iec958-dts-surround-51+input:mono-fallback - will not be able to open output:iec958-dts-surround-51
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:iec958-dts-surround-51+input:multichannel-input - will not be able to open output:iec958-dts-surround-51
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:hdmi-stereo+input:stereo-fallback - will not be able to open output:hdmi-stereo
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:hdmi-stereo+input:mono-fallback - will not be able to open output:hdmi-stereo
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:hdmi-stereo+input:multichannel-input - will not be able to open output:hdmi-stereo
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:hdmi-surround+input:stereo-fallback - will not be able to open output:hdmi-surround
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:hdmi-surround+input:mono-fallback - will not be able to open output:hdmi-surround
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:hdmi-surround+input:multichannel-input - will not be able to open output:hdmi-surround
Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c: Skipping profile output:hdmi-surround71+input:stereo-fallback - will not be able to open output:hdmi-surround71
After the Apr 29 19:20:19 pine64 59b989a3af35[1684]: D: [pulseaudio] alsa-mixer.c entry, the machine rebooted.
docker image list shows that the following images have been downloaded:
# docker image list
docker image list
REPOSITORY TAG IMAGE ID CREATED SIZE
homeassistant/aarch64-hassio-supervisor 2021.04.0 acbd7433b5da 3 weeks ago 320MB
homeassistant/aarch64-hassio-supervisor latest acbd7433b5da 3 weeks ago 320MB
homeassistant/aarch64-hassio-cli <none> 695850464612 4 weeks ago 97.7MB
homeassistant/aarch64-hassio-audio 2021.02.1 1334ff308080 2 months ago 121MB
homeassistant/aarch64-hassio-dns 2021.01.0 0224debe9b36 3 months ago 113MB
When I looked through the log, I can see an entry Starting Audio homeassistant/aarch64-hassio-audio with version 2021.02.1 - 172.30.32.4 shortly after which the pulseaudio messages start.
The only remotely related forum thread I can find is this one. I did try applying the fix mentioned in the thread but it has no affect.
Would appreciate any help/inputs I can get!