Setup on Debian fails #286
Comments
|
I've encountered the same problem. But for me this broke an existing, working installation - when trying to debug the journald-gateway "unsupported" state (which I've already fixed half a year ago, but it showed up again...), I tried updating The workaround was to remove the package, download the previous release (1.4.1) and install that instead: sudo apt remove -y homeassistant-supervised
wget https://github.com/home-assistant/supervised-installer/releases/download/1.4.1/homeassistant-supervised.deb -O homeassistant-supervised-1.4.1.deb
sudo apt install -y ./homeassistant-supervised-1.4.1.debI wish there was an error message in addition to the "exit 1" somewhere in the middle of the setup script - as it is now there is no indication as to what causes the error, no message in logs and no easily googlable error code. Full output from journal during `apt -f install`
May 03 21:55:22 hass sudo[2941]: hass : TTY=pts/0 ; PWD=/home/hass ; USER=root ; COMMAND=/usr/bin/apt -f install
May 03 21:55:22 hass sudo[2941]: pam_unix(sudo:session): session opened for user root(uid=0) by hass(uid=1000)
May 03 21:55:23 hass systemd[1]: NetworkManager-wait-online.service: Succeeded.
May 03 21:55:23 hass systemd[1]: Stopped Network Manager Wait Online.
May 03 21:55:23 hass systemd[1]: Stopping Network Manager Wait Online...
May 03 21:55:23 hass NetworkManager[2683]: <info> [1683143723.3477] caught SIGTERM, shutting down normally.
May 03 21:55:23 hass systemd[1]: Stopping Network Manager...
May 03 21:55:23 hass NetworkManager[2683]: <info> [1683143723.3754] dhcp4 (enp0s31f6): canceled DHCP transaction
May 03 21:55:23 hass NetworkManager[2683]: <info> [1683143723.3755] dhcp4 (enp0s31f6): state changed bound -> terminated
May 03 21:55:23 hass NetworkManager[2683]: <info> [1683143723.3760] manager: NetworkManager state is now CONNECTED_SITE
May 03 21:55:23 hass dbus-daemon[501]: [system] Activating via systemd: service name='org.freedesktop.nm_dispatcher' unit='dbus-org.freedesktop.nm-dispatcher.service' requested by ':1.62' (uid=0 pid=2683 comm="/usr/sbin/NetworkManager --no-daemon ")
May 03 21:55:23 hass NetworkManager[2683]: <info> [1683143723.3790] device (wlp2s0): state change: disconnected -> unmanaged (reason 'unmanaged', sys-iface-state: 'managed')
May 03 21:55:23 hass wpa_supplicant[516]: nl80211: deinit ifname=p2p-dev-wlp2s0 disabled_11b_rates=0
May 03 21:55:23 hass NetworkManager[2683]: <info> [1683143723.4100] device (p2p-dev-wlp2s0): state change: disconnected -> unmanaged (reason 'removed', sys-iface-state: 'removed')
May 03 21:55:23 hass systemd[1]: Starting Network Manager Script Dispatcher Service...
May 03 21:55:23 hass NetworkManager[2683]: <info> [1683143723.4267] exiting (success)
May 03 21:55:23 hass dbus-daemon[501]: [system] Successfully activated service 'org.freedesktop.nm_dispatcher'
May 03 21:55:23 hass systemd[1]: NetworkManager.service: Succeeded.
May 03 21:55:23 hass systemd[1]: Stopped Network Manager.
May 03 21:55:23 hass systemd[1]: Started Network Manager Script Dispatcher Service.
May 03 21:55:23 hass systemd[1]: Starting Network Manager...
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.4599] NetworkManager (version 1.30.6) is starting... (after a restart)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.4600] Read config: /etc/NetworkManager/NetworkManager.conf (lib: no-mac-addr-change.conf)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.4616] bus-manager: acquired D-Bus service "org.freedesktop.NetworkManager"
May 03 21:55:23 hass systemd[1]: Started Network Manager.
May 03 21:55:23 hass systemd[1]: Starting Network Manager Wait Online...
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.4901] manager[0x557cb466e030]: monitoring kernel firmware directory '/lib/firmware'.
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.4902] monitoring ifupdown state file '/run/network/ifstate'.
May 03 21:55:23 hass dbus-daemon[501]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.74' (uid=0 pid=2973 comm="/usr/sbin/NetworkManager --no-daemon ")
May 03 21:55:23 hass systemd[1]: Starting Hostname Service...
May 03 21:55:23 hass wpa_supplicant[516]: nl80211: deinit ifname=wlp2s0 disabled_11b_rates=0
May 03 21:55:23 hass dbus-daemon[501]: [system] Successfully activated service 'org.freedesktop.hostname1'
May 03 21:55:23 hass systemd[1]: Started Hostname Service.
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5470] hostname: hostname: using hostnamed
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5471] hostname: hostname changed from (none) to "hass"
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5479] dns-mgr[0x557cb4658170]: init: dns=default,systemd-resolved rc-manager=file
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5489] rfkill0: found Wi-Fi radio killswitch (at /sys/devices/pci0000:00/0000:00:1d.0/0000:02:00.0/ieee80211/phy0/rfkill0) (driver iwlwifi)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5491] manager[0x557cb466e030]: rfkill: Wi-Fi hardware radio set enabled
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5491] manager[0x557cb466e030]: rfkill: WWAN hardware radio set enabled
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5500] Loaded device plugin: NMWifiFactory (/usr/lib/x86_64-linux-gnu/NetworkManager/1.30.6/libnm-device-plugin-wifi.so)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5502] Loaded device plugin: NMAtmManager (/usr/lib/x86_64-linux-gnu/NetworkManager/1.30.6/libnm-device-plugin-adsl.so)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5510] Loaded device plugin: NMTeamFactory (/usr/lib/x86_64-linux-gnu/NetworkManager/1.30.6/libnm-device-plugin-team.so)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5526] Loaded device plugin: NMWwanFactory (/usr/lib/x86_64-linux-gnu/NetworkManager/1.30.6/libnm-device-plugin-wwan.so)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5530] Loaded device plugin: NMBluezManager (/usr/lib/x86_64-linux-gnu/NetworkManager/1.30.6/libnm-device-plugin-bluetooth.so)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5532] manager: rfkill: Wi-Fi enabled by radio killswitch; enabled by state file
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5533] manager: rfkill: WWAN enabled by radio killswitch; enabled by state file
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5534] manager: Networking is enabled by state file
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5534] dhcp-init: Using DHCP client 'internal'
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5535] settings: Loaded settings plugin: keyfile (internal)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5562] device (lo): carrier: link connected
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5564] manager: (lo): new Generic device (/org/freedesktop/NetworkManager/Devices/1)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5569] manager: (docker0): new Bridge device (/org/freedesktop/NetworkManager/Devices/2)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5573] device (enp0s31f6): carrier: link connected
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5576] manager: (enp0s31f6): new Ethernet device (/org/freedesktop/NetworkManager/Devices/3)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5584] manager: (enp0s31f6): assume: will attempt to assume matching connection 'Supervisor enp0s31f6' (dc515952-289f-4fc1-b838-6e29a98ef3a2) (indicated)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5584] device (enp0s31f6): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5591] device (enp0s31f6): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5598] device (enp0s31f6): Activation: starting connection 'Supervisor enp0s31f6' (dc515952-289f-4fc1-b838-6e29a98ef3a2)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5602] manager: (hassio): new Bridge device (/org/freedesktop/NetworkManager/Devices/4)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5608] manager: (wg0): new WireGuard device (/org/freedesktop/NetworkManager/Devices/5)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5614] device (wg0): state change: unmanaged -> unavailable (reason 'connection-assumed', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5618] device (wg0): state change: unavailable -> disconnected (reason 'connection-assumed', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5622] device (wg0): Activation: starting connection 'wg0' (e2e396f4-d141-42ae-9295-d1fdefddaed6)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5623] device (wlp2s0): driver supports Access Point (AP) mode
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5628] manager: (wlp2s0): new 802.11 Wi-Fi device (/org/freedesktop/NetworkManager/Devices/6)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.5633] device (wlp2s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
May 03 21:55:23 hass sudo[2941]: pam_unix(sudo:session): session closed for user root
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8221] device (enp0s31f6): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8229] device (enp0s31f6): state change: prepare -> config (reason 'none', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8259] device (wg0): state change: disconnected -> prepare (reason 'none', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8266] device (wg0): state change: prepare -> config (reason 'none', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8394] device (wg0): state change: config -> ip-config (reason 'none', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8398] device (wg0): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8413] device (enp0s31f6): state change: config -> ip-config (reason 'none', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8418] dhcp4 (enp0s31f6): activation: beginning transaction (timeout in 45 seconds)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8432] device (enp0s31f6): state change: ip-config -> ip-check (reason 'none', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8489] dhcp4 (enp0s31f6): state changed unknown -> bound, address=10.0.0.20
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8495] device (wg0): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8509] device (enp0s31f6): state change: ip-check -> secondaries (reason 'none', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8515] device (wg0): state change: secondaries -> activated (reason 'none', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8519] manager: NetworkManager state is now CONNECTED_LOCAL
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8528] policy: set 'Supervisor enp0s31f6' (enp0s31f6) as default for IPv4 routing and DNS
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8565] device (wg0): Activation: successful, device activated.
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8570] device (enp0s31f6): state change: secondaries -> activated (reason 'none', sys-iface-state: 'assume')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8576] manager: NetworkManager state is now CONNECTED_SITE
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8583] device (enp0s31f6): Activation: successful, device activated.
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8648] manager: NetworkManager state is now CONNECTED_GLOBAL
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8914] device (wlp2s0): supplicant interface state: internal-starting -> disconnected
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8914] Wi-Fi P2P device controlled by interface wlp2s0 created
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8916] manager: (p2p-dev-wlp2s0): new 802.11 Wi-Fi P2P device (/org/freedesktop/NetworkManager/Devices/7)
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8918] device (p2p-dev-wlp2s0): state change: unmanaged -> unavailable (reason 'managed', sys-iface-state: 'external')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8922] device (wlp2s0): state change: unavailable -> disconnected (reason 'supplicant-available', sys-iface-state: 'managed')
May 03 21:55:23 hass NetworkManager[2973]: <info> [1683143723.8927] device (p2p-dev-wlp2s0): state change: unavailable -> disconnected (reason 'none', sys-iface-state: 'managed')
May 03 21:55:23 hass NetworkManager[2973]: <warn> [1683143723.8931] sup-iface[c4da2c979152e1cb,7,wlp2s0]: call-p2p-cancel: failed with P2P cancel failed
May 03 21:55:27 hass wpa_supplicant[516]: wlp2s0: CTRL-EVENT-REGDOM-CHANGE init=DRIVER type=COUNTRY alpha2=EU
May 03 21:55:27 hass NetworkManager[2973]: <info> [1683143727.1033] manager: startup complete
May 03 21:55:27 hass systemd[1]: Finished Network Manager Wait Online. |
|
Struggling for hours! You made my day! |
|
Same error here with ubuntu 22.04, but downgrading to 1.4.1 does not fix the issue for me |
|
I can confirm that installing under Debian 12.1 works except that systemd-resolved does not point to any DNS server. |
|
After upgrading my base system to Debian 12 I've hit an issue looking identically to this one again... This time it was the sudo apt install --reinstall systemd-journal-remoteOh, and also I had to set the DNS server as per #304. The main issue here is that the post-installation script is very fragile, handles only the very happy path and doesn't correctly report errors - here this line was failing but the error message was redirected to For future reference, debugging the postinst script (based on this SE question on editing postinst): # Get the latest homeassistant-supervised
wget -O homeassistant-supervised.deb https://github.com/home-assistant/supervised-installer/releases/latest/download/homeassistant-supervised.deb
# Unpack the deb
mkdir hass-sv
dpkg-deb -R homeassistant-supervised.deb hass-sv
# open the postinst script - try running the suspected problem lines manually
nano hass-sv/DEBIAN/postinstFor modifying the script and repacking the deb with modifications: fakeroot sh -c '
mkdir hass-sv;
dpkg-deb -R homeassistant-supervised.deb hass-sv;
nano hass-sv/DEBIAN/postinst;
dpkg-deb -b hass-sv homeassistant-supervised-fix.deb
'(replace nano with your choice of editor) |
|
But wait, there's more! After the update the supervisor started complaining that it's "not privileged". The issue card only links to a BS page describing neither the issue nor any real solutions - the supervisor container WAS running in the privileged mode, but it had some weird issues accessing udev (logs entry: Here's a solution, based on this old discussion: docker container rm -f hassio_supervisor
sudo systemctl restart hassio-supervisor.serviceI feel that absolutely no one tests any upgrade path for HASupervised, as it's yet another situation where it breaks because of it's own previous versions' actions... |
|
@mjbogusz I think you are absolutly right - no real testing is done, as this is the method nabucasa was sort-of forced into maintaining inspite of their choice. At least we have a good community here with detailed bug reports. We'll do the testing. I'm guessing if you PR this, they will approve it. |
are you using a static DNS or DHCP provided DNS? |
In trying to solve this I discovered a very strange issue, after the container is destroyed on recreation it displays the error, once the container is started if I restart it again a second time the error message disappears, currently trying to figure out the root cause... if anyone has some insight into what could be causing this let me know |
|
There hasn't been any activity on this issue recently. Due to the high number of incoming GitHub notifications, we have to clean some of the old issues, as many of them have already been resolved with the latest updates. |
OS Version
Debian GNU/Linux 11 (bullseye)
System Information
Linux Domotica01 5.10.0-21-amd64 #1 SMP Debian 5.10.162-1 (2023-01-21) x86_64 GNU/Linux
What happened?
I'm having an issue installing HA supervised (homeassistant-supervised.deb)
Machine Type
generic-x86-64
Installer output
Relevant log output
ADR
Code of Conduct
The text was updated successfully, but these errors were encountered: