Mar 06 17:47:00 254muzika systemd[1]: Starting plymouth-start.service - Show Plymouth Boot Screen... Mar 06 17:47:00 254muzika systemd[1]: Finished systemd-tmpfiles-setup.service - Create System Files and Directories. Mar 06 17:47:00 254muzika systemd[1]: Found device sys-subsystem-net-devices-eth0.device - 7800. Mar 06 17:47:00 254muzika systemd[1]: Mounting proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System... Mar 06 17:47:00 254muzika systemd[1]: Mounting run-rpc_pipefs.mount - RPC Pipe File System... Mar 06 17:47:00 254muzika systemd[1]: Started haveged.service - Entropy Daemon based on the HAVEGE algorithm. Mar 06 17:47:00 254muzika systemd[1]: Started ifup@eth0.service - ifup for eth0. Mar 06 17:47:00 254muzika systemd[1]: Starting rpcbind.service - RPC bind portmap service... Mar 06 17:47:00 254muzika systemd[1]: Starting systemd-update-utmp.service - Record System Boot/Shutdown in UTMP... Mar 06 17:47:00 254muzika systemd[1]: Mounted proc-sys-fs-binfmt_misc.mount - Arbitrary Executable File Formats File System. Mar 06 17:47:00 254muzika systemd[1]: Mounted run-rpc_pipefs.mount - RPC Pipe File System. Mar 06 17:47:00 254muzika systemd[1]: Reached target rpc_pipefs.target. Mar 06 17:47:00 254muzika systemd[1]: rpc-gssd.service - RPC security service for NFS client and server was skipped because of an unmet condition check (ConditionPathExists=/etc/krb5.keytab). Mar 06 17:47:00 254muzika systemd[1]: Reached target nfs-client.target - NFS client services. Mar 06 17:47:00 254muzika systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. Mar 06 17:47:00 254muzika systemd[1]: Started plymouth-start.service - Show Plymouth Boot Screen. Mar 06 17:47:00 254muzika systemd[1]: systemd-ask-password-console.path - Dispatch Password Requests to Console Directory Watch was skipped because of an unmet condition check (ConditionPathExists=!/run/plymouth/pid). Mar 06 17:47:00 254muzika systemd[1]: Started systemd-ask-password-plymouth.path - Forward Password Requests to Plymouth Directory Watch. Mar 06 17:47:00 254muzika systemd[1]: Reached target cryptsetup.target - Local Encrypted Volumes. Mar 06 17:47:00 254muzika systemd[1]: Reached target paths.target - Path Units. Mar 06 17:47:00 254muzika systemd[1]: Finished systemd-update-utmp.service - Record System Boot/Shutdown in UTMP. Mar 06 17:47:00 254muzika systemd[1]: Reached target sysinit.target - System Initialization. Mar 06 17:47:00 254muzika systemd[1]: apt-daily.timer: Not using persistent file timestamp Tue 2026-08-25 07:51:00 CEST as it is in the future. Mar 06 17:47:00 254muzika systemd[1]: Started apt-daily.timer - Daily apt download activities. Mar 06 17:47:00 254muzika systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Tue 2026-08-25 06:36:11 CEST as it is in the future. Mar 06 17:47:00 254muzika systemd[1]: Started apt-daily-upgrade.timer - Daily apt upgrade and clean activities. Mar 06 17:47:00 254muzika systemd[1]: dpkg-db-backup.timer: Not using persistent file timestamp Tue 2026-08-25 00:00:00 CEST as it is in the future. Mar 06 17:47:00 254muzika systemd[1]: Started dpkg-db-backup.timer - Daily dpkg database backup timer. Mar 06 17:47:00 254muzika systemd[1]: e2scrub_all.timer: Not using persistent file timestamp Sun 2026-08-23 03:10:21 CEST as it is in the future. Mar 06 17:47:00 254muzika systemd[1]: Started e2scrub_all.timer - Periodic ext4 Online Metadata Check for All Filesystems. Mar 06 17:47:00 254muzika systemd[1]: fstrim.timer: Not using persistent file timestamp Mon 2026-08-24 00:20:31 CEST as it is in the future. Mar 06 17:47:00 254muzika systemd[1]: Started fstrim.timer - Discard unused blocks once a week. Mar 06 17:47:00 254muzika systemd[1]: ntpsec-rotate-stats.timer: Not using persistent file timestamp Tue 2026-08-25 06:25:07 CEST as it is in the future. Mar 06 17:47:00 254muzika systemd[1]: Started ntpsec-rotate-stats.timer - Rotate ntpd stats daily. Mar 06 17:47:00 254muzika systemd[1]: Started setdatetime-helper.timer - Volumio Time Sync Watchdog Timer. Mar 06 17:47:00 254muzika systemd[1]: Started systemd-tmpfiles-clean.timer - Daily Cleanup of Temporary Directories. Mar 06 17:47:00 254muzika systemd[1]: Reached target timers.target - Timer Units. Mar 06 17:47:00 254muzika systemd[1]: Listening on avahi-daemon.socket - Avahi mDNS/DNS-SD Stack Activation Socket. Mar 06 17:47:00 254muzika systemd[1]: Listening on dbus.socket - D-Bus System Message Bus Socket. Mar 06 17:47:00 254muzika systemd[1]: Reached target sockets.target - Socket Units. Mar 06 17:47:00 254muzika systemd[1]: systemd-pcrphase-sysinit.service - TPM2 PCR Barrier (Initialization) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Mar 06 17:47:00 254muzika systemd[1]: Reached target basic.target - Basic System. Mar 06 17:47:00 254muzika systemd[1]: alsa-state.service - Manage Sound Card State (restore and store) was skipped because of an unmet condition check (ConditionPathExists=/etc/alsa/state-daemon.conf). Mar 06 17:47:00 254muzika kernel: Bluetooth: hci0: BCM: chip id 107 Mar 06 17:47:00 254muzika kernel: Bluetooth: hci0: BCM: features 0x2f Mar 06 17:47:00 254muzika kernel: Bluetooth: hci0: BCM4345C0 Mar 06 17:47:00 254muzika kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0000 Mar 06 17:47:00 254muzika kernel: Bluetooth: hci0: BCM4345C0 'brcm/BCM4345C0.raspberrypi,3-model-b-plus.hcd' Patch Mar 06 17:47:00 254muzika systemd[1]: Starting alsa-restore.service - Save/Restore Sound Card State... Mar 06 17:47:00 254muzika systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Mar 06 17:47:00 254muzika systemd[1]: Starting dbus.service - D-Bus System Message Bus... Mar 06 17:47:00 254muzika systemd[1]: Starting e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots... Mar 06 17:47:00 254muzika systemd[1]: getty-static.service - getty on tty2-tty6 if dbus and logind are not available was skipped because of an unmet condition check (ConditionPathExists=!/usr/bin/dbus-daemon). Mar 06 17:47:00 254muzika systemd[1]: headless_wireless.service - Copy user wpa_supplicant.conf was skipped because of an unmet condition check (ConditionPathExists=/boot/wpa_supplicant.conf). Mar 06 17:47:00 254muzika systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces... Mar 06 17:47:00 254muzika systemd[1]: Started iptables.service - Volumio Iptables Module. Mar 06 17:47:00 254muzika systemd[1]: Starting rpi-eeprom-update.service - Check for Raspberry Pi EEPROM updates... Mar 06 17:47:00 254muzika kernel: brcmfmac: F1 signature read @0x18000000=0x15264345 Mar 06 17:47:00 254muzika kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43455-sdio for chip BCM4345/6 Mar 06 17:47:00 254muzika kernel: usbcore: registered new interface driver brcmfmac Mar 06 17:47:00 254muzika systemd[1]: Starting systemd-logind.service - User Login Management... Mar 06 17:47:00 254muzika systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Mar 06 17:47:00 254muzika systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:47:00 254muzika systemd[1]: Started volumio-remote-updater.service - Volumio Remote OTA Updater. Mar 06 17:47:00 254muzika systemd[1]: volumiossh.service - Volumio SSH enabler was skipped because of an unmet condition check (ConditionPathExistsGlob=/boot/ssh{,.txt}). Mar 06 17:47:00 254muzika systemd[1]: Starting wireless.service - Wireless Services... Mar 06 17:47:00 254muzika sh[606]: command failed: No such device (-19) Mar 06 17:47:00 254muzika thd[621]: Unable to parse trigger line: Mar 06 17:47:00 254muzika thd[621]: Unable to parse trigger line: Mar 06 17:47:00 254muzika avahi-daemon[607]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Mar 06 17:47:00 254muzika avahi-daemon[607]: Successfully dropped root privileges. Mar 06 17:47:00 254muzika avahi-daemon[607]: avahi-daemon 0.8 starting up. Mar 06 17:47:00 254muzika systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Mar 06 17:47:00 254muzika systemd[1]: Starting th-udev-rebind.service - Late rebind of input devices to triggerhappy... Mar 06 17:47:00 254muzika alsactl[634]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Mar 06 17:47:00 254muzika alsactl[634]: No state is present for card b1 Mar 06 17:47:00 254muzika alsactl[634]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Mar 06 17:47:00 254muzika alsactl[634]: /usr/share/alsa/init/bcm2835:14: control element not found Mar 06 17:47:00 254muzika alsactl[634]: No state is present for card b1 Mar 06 17:47:00 254muzika alsactl[634]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Mar 06 17:47:00 254muzika alsactl[634]: No state is present for card Headphones Mar 06 17:47:00 254muzika alsactl[634]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Mar 06 17:47:00 254muzika alsactl[634]: /usr/share/alsa/init/bcm2835:20: control element not found Mar 06 17:47:00 254muzika alsactl[634]: No state is present for card Headphones Mar 06 17:47:00 254muzika alsactl[634]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Mar 06 17:47:00 254muzika alsactl[634]: No state is present for card vc4hdmi Mar 06 17:47:00 254muzika th-udev-rebind.sh[638]: Rebinding /dev/input/event0 to thd using --add... Mar 06 17:47:00 254muzika alsactl[634]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Mar 06 17:47:00 254muzika alsactl[634]: Found hardware: "vc4-hdmi" "" "" "" "" Mar 06 17:47:00 254muzika alsactl[634]: Hardware is initialized using a generic method Mar 06 17:47:00 254muzika alsactl[634]: No state is present for card vc4hdmi Mar 06 17:47:00 254muzika systemd[1]: Finished alsa-restore.service - Save/Restore Sound Card State. Mar 06 17:47:00 254muzika systemd[1]: Reached target sound.target - Sound Card. Mar 06 17:47:00 254muzika th-udev-rebind.sh[638]: Rebinding /dev/input/event1 to thd using --add... Mar 06 17:47:00 254muzika systemd[1]: th-udev-rebind.service: Deactivated successfully. Mar 06 17:47:00 254muzika systemd[1]: Finished th-udev-rebind.service - Late rebind of input devices to triggerhappy. Mar 06 17:47:00 254muzika systemd[1]: Started rpcbind.service - RPC bind portmap service. Mar 06 17:47:00 254muzika systemd[1]: Reached target remote-fs-pre.target - Preparation for Remote File Systems. Mar 06 17:47:00 254muzika systemd[1]: Reached target remote-fs.target - Remote File Systems. Mar 06 17:47:00 254muzika systemd[1]: Reached target rpcbind.target - RPC Port Mapper. Mar 06 17:47:00 254muzika rpi-eeprom-update[612]: Device does not a have a Raspberry Pi bootloader EEPROM (e.g. Pi 4 or Pi 5). Skipping bootloader update. Mar 06 17:47:00 254muzika haveged[589]: haveged: command socket is listening at fd 3 Mar 06 17:47:00 254muzika systemd[1]: Starting loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling... Mar 06 17:47:00 254muzika systemd[1]: systemd-pcrphase.service - TPM2 PCR Barrier (User) was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/StubPcrKernelImage-4a67b082-0a4c-41cf-b6c7-440b29bb8c4f). Mar 06 17:47:00 254muzika systemd[1]: Finished rpi-eeprom-update.service - Check for Raspberry Pi EEPROM updates. Mar 06 17:47:00 254muzika systemd[1]: e2scrub_reap.service: Deactivated successfully. Mar 06 17:47:00 254muzika systemd[1]: Finished e2scrub_reap.service - Remove Stale Online ext4 Metadata Check Snapshots. Mar 06 17:47:01 254muzika kernel: brcmfmac: brcmf_c_process_txcap_blob: no txcap_blob available (err=-2) Mar 06 17:47:01 254muzika kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM4345/6 wl0: Aug 29 2023 01:47:08 version 7.45.265 (28bca26 CY) FWID 01-b677b91b Mar 06 17:47:01 254muzika kernel: Bluetooth: hci0: BCM: features 0x2f Mar 06 17:47:01 254muzika kernel: Bluetooth: hci0: BCM43455 37.4MHz Raspberry Pi 3+-0190 Mar 06 17:47:01 254muzika kernel: Bluetooth: hci0: BCM4345C0 (003.001.025) build 0382 Mar 06 17:47:01 254muzika systemd-logind[619]: New seat seat0. Mar 06 17:47:01 254muzika kernel: Bluetooth: hci0: BCM: Using default device address (43:45:c0:00:1f:ac) Mar 06 17:47:01 254muzika systemd-logind[619]: Watching system buttons on /dev/input/event0 (vc4-hdmi) Mar 06 17:47:01 254muzika dhcpcd[610]: dhcpcd-9.4.1 starting Mar 06 17:47:01 254muzika dhcpcd[668]: dev: loaded udev Mar 06 17:47:01 254muzika dhcpcd[668]: DUID 00:01:00:01:31:3d:c1:84:b8:27:eb:2a:36:4f Mar 06 17:47:01 254muzika kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Down Mar 06 17:47:01 254muzika kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 06 17:47:01 254muzika kernel: 8021q: adding VLAN 0 to HW filter on device eth0 Mar 06 17:47:01 254muzika systemd[1]: Started dbus.service - D-Bus System Message Bus. Mar 06 17:47:01 254muzika avahi-daemon[607]: Successfully called chroot(). Mar 06 17:47:01 254muzika avahi-daemon[607]: Successfully dropped remaining capabilities. Mar 06 17:47:01 254muzika avahi-daemon[607]: Loading service file /services/volumio.service. Mar 06 17:47:01 254muzika dbus-daemon[608]: [system] Successfully activated service 'org.freedesktop.systemd1' Mar 06 17:47:01 254muzika loadcpufreq[645]: Loading cpufreq kernel modules...done (none). Mar 06 17:47:01 254muzika avahi-daemon[607]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Mar 06 17:47:01 254muzika avahi-daemon[607]: New relevant interface lo.IPv4 for mDNS. Mar 06 17:47:01 254muzika avahi-daemon[607]: Network interface enumeration completed. Mar 06 17:47:01 254muzika avahi-daemon[607]: Registering new address record for 127.0.0.1 on lo.IPv4. Mar 06 17:47:01 254muzika systemd[1]: Starting wpa_supplicant.service - WPA supplicant... Mar 06 17:47:01 254muzika systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces. Mar 06 17:47:01 254muzika systemd[1]: Started loadcpufreq.service - LSB: Load kernel modules needed to enable cpufreq scaling. Mar 06 17:47:01 254muzika systemd[1]: Started systemd-logind.service - User Login Management. Mar 06 17:47:01 254muzika systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Mar 06 17:47:01 254muzika systemd[1]: Starting cpufrequtils.service - LSB: set CPUFreq kernel parameters... Mar 06 17:47:01 254muzika systemd[1]: iptables.service: Deactivated successfully. Mar 06 17:47:02 254muzika dhcpcd[668]: eth0: waiting for carrier Mar 06 17:47:02 254muzika cpufrequtils[722]: CPUFreq Utilities: Setting ondemand CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Mar 06 17:47:02 254muzika systemd[1]: Started cpufrequtils.service - LSB: set CPUFreq kernel parameters. Mar 06 17:47:02 254muzika sh[768]: eth0=eth0 Mar 06 17:47:02 254muzika systemd[1]: Listening on systemd-rfkill.socket - Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 06 17:47:02 254muzika (udev-worker)[455]: Network interface NamePolicy= disabled on kernel command line. Mar 06 17:47:02 254muzika wpa_supplicant[711]: Successfully initialized wpa_supplicant Mar 06 17:47:02 254muzika systemd[1]: Starting systemd-rfkill.service - Load/Save RF Kill Switch Status... Mar 06 17:47:02 254muzika systemd[1]: Started wpa_supplicant.service - WPA supplicant. Mar 06 17:47:02 254muzika volumio-remote-updater[624]: Volumio OTA Client: 1.7.0 Mar 06 17:47:02 254muzika volumio-remote-updater[624]: Error: No active session Mar 06 17:47:02 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:02] [info] asio async_connect error: asio.system:111 (Connection refused) Mar 06 17:47:02 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:02] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Mar 06 17:47:02 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:02] [error] handle_connect error: Connection refused Mar 06 17:47:02 254muzika systemd[1]: Expecting device sys-subsystem-net-devices-wlan0.device - /sys/subsystem/net/devices/wlan0... Mar 06 17:47:02 254muzika (udev-worker)[463]: hci0: Process '/usr/bin/hciconfig hci0 up' failed with exit code 1. Mar 06 17:47:02 254muzika avahi-daemon[607]: Server startup complete. Host name is 254muzika.local. Local service cookie is 440940152. Mar 06 17:47:02 254muzika systemd[1]: Started systemd-rfkill.service - Load/Save RF Kill Switch Status. Mar 06 17:47:02 254muzika systemd[1]: Found device sys-subsystem-net-devices-wlan0.device - /sys/subsystem/net/devices/wlan0. Mar 06 17:47:02 254muzika haveged[589]: haveged: ver: 1.9.14; arch: generic; vend: ; build: (gcc 10.2.1 CTV); collect: 128K Mar 06 17:47:02 254muzika haveged[589]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14748/63356 Mar 06 17:47:02 254muzika haveged[589]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99683 Mar 06 17:47:02 254muzika haveged[589]: haveged: fills: 0, generated: 0 Mar 06 17:47:02 254muzika dhcpcd[668]: wlan0: waiting for carrier Mar 06 17:47:02 254muzika kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save enabled Mar 06 17:47:02 254muzika systemd[1]: Starting bluetooth.service - Bluetooth service... Mar 06 17:47:02 254muzika systemd[1]: Started ifup@wlan0.service - ifup for wlan0. Mar 06 17:47:02 254muzika systemd[1]: Finished ifupdown-pre.service - Helper to synchronize boot up for ifupdown. Mar 06 17:47:02 254muzika systemd[1]: Starting networking.service - Raise network interfaces... Mar 06 17:47:02 254muzika upmpdcli[623]: Could not open config: /tmp/upmpdcli.conf Mar 06 17:47:02 254muzika kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 06 17:47:02 254muzika kernel: warning: `iwconfig' uses wireless extensions which will stop working for Wi-Fi 7 hardware; use nl80211 Mar 06 17:47:02 254muzika systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 06 17:47:02 254muzika systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 06 17:47:02 254muzika sh[868]: wlan0=wlan0 Mar 06 17:47:03 254muzika systemd[1]: Finished networking.service - Raise network interfaces. Mar 06 17:47:03 254muzika systemd[1]: Reached target network.target - Network. Mar 06 17:47:03 254muzika systemd[1]: Reached target network-online.target - Network is Online. Mar 06 17:47:03 254muzika systemd[1]: Starting ifplugd.service - LSB: Brings up/down network automatically... Mar 06 17:47:03 254muzika systemd[1]: Starting nmbd.service - Samba NMB Daemon... Mar 06 17:47:03 254muzika systemd[1]: Starting ntpsec.service - Network Time Service... Mar 06 17:47:03 254muzika systemd[1]: Starting rc-local.service - /etc/rc.local Compatibility... Mar 06 17:47:03 254muzika systemd[1]: Starting rpc-statd-notify.service - Notify NFS peers of a restart... Mar 06 17:47:03 254muzika systemd[1]: Starting samba-ad-dc.service - Samba AD Daemon... Mar 06 17:47:03 254muzika systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 06 17:47:03 254muzika sm-notify[898]: Version 2.6.2 starting Mar 06 17:47:03 254muzika systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 06 17:47:03 254muzika bluetoothd[783]: Bluetooth daemon 5.83 Mar 06 17:47:03 254muzika bluetoothd[783]: Starting SDP server Mar 06 17:47:03 254muzika bluetoothd[783]: Excluding (cli) sap Mar 06 17:47:03 254muzika bluetoothd[783]: Excluding (cli) scanparam Mar 06 17:47:03 254muzika bluetoothd[783]: Excluding (cli) midi Mar 06 17:47:03 254muzika bluetoothd[783]: Excluding (cli) battery Mar 06 17:47:03 254muzika systemd[1]: Starting ssh.service - OpenBSD Secure Shell server... Mar 06 17:47:03 254muzika systemd[1]: Starting systemd-user-sessions.service - Permit User Sessions... Mar 06 17:47:03 254muzika systemd[1]: Started volumio-ipchange.service - Volumio IP Change Monitor. Mar 06 17:47:03 254muzika systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 06 17:47:03 254muzika systemd[1]: Started rc-local.service - /etc/rc.local Compatibility. Mar 06 17:47:03 254muzika systemd[1]: Started rpc-statd-notify.service - Notify NFS peers of a restart. Mar 06 17:47:03 254muzika systemd[1]: Started bluetooth.service - Bluetooth service. Mar 06 17:47:03 254muzika systemd[1]: Finished systemd-user-sessions.service - Permit User Sessions. Mar 06 17:47:03 254muzika kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 06 17:47:03 254muzika kernel: Bluetooth: BNEP filters: protocol multicast Mar 06 17:47:03 254muzika kernel: Bluetooth: BNEP socket layer initialized Mar 06 17:47:03 254muzika avahi-daemon[607]: Service "254_muzika" (/services/volumio.service) successfully established. Mar 06 17:47:03 254muzika kernel: Bluetooth: MGMT ver 1.23 Mar 06 17:47:03 254muzika bluetoothd[783]: Bluetooth management interface 1.23 initialized Mar 06 17:47:03 254muzika bluetoothd[783]: Battery Provider Manager created Mar 06 17:47:03 254muzika dbus-daemon[608]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.4' (uid=0 pid=783 comm="/usr/libexec/bluetooth/bluetoothd --noplugin=sap,b") Mar 06 17:47:03 254muzika ntpd[908]: INIT: ntpd ntpsec-1.2.2: Starting Mar 06 17:47:03 254muzika ntpd[908]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Mar 06 17:47:03 254muzika ntp-systemd-wrapper[908]: 2026-03-06T17:47:03 ntpd[908]: INIT: ntpd ntpsec-1.2.2: Starting Mar 06 17:47:03 254muzika ntp-systemd-wrapper[908]: 2026-03-06T17:47:03 ntpd[908]: INIT: Command line: /usr/sbin/ntpd -p /run/ntpd.pid -c /etc/ntpsec/ntp.conf -g -N -u ntpsec:ntpsec Mar 06 17:47:03 254muzika systemd[1]: Starting bluealsa.service - BlueALSA service... Mar 06 17:47:03 254muzika systemd[1]: Starting plymouth-quit-wait.service - Hold until boot process finishes up... Mar 06 17:47:03 254muzika systemd[1]: Started ntpsec.service - Network Time Service. Mar 06 17:47:03 254muzika welcome[913]: Resolved ip:[0] Mar 06 17:47:03 254muzika kernel: NET: Registered PF_ALG protocol family Mar 06 17:47:03 254muzika ntpd[937]: INIT: precision = 0.885 usec (-20) Mar 06 17:47:03 254muzika ntpd[937]: INIT: successfully locked into RAM Mar 06 17:47:03 254muzika ntpd[937]: CONFIG: readconfig: parsing file: /etc/ntpsec/ntp.conf Mar 06 17:47:03 254muzika ntpd[937]: CONFIG: restrict nopeer ignored Mar 06 17:47:03 254muzika ntpd[937]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 06 17:47:03 254muzika ntpd[937]: CLOCK: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2026-06-28T00:00Z last=2017-01-01T00:00Z ofs=37 Mar 06 17:47:03 254muzika ntpd[937]: INIT: Using SO_TIMESTAMPNS(ns) Mar 06 17:47:03 254muzika ntpd[937]: IO: Listen and drop on 0 v6wildcard [::]:123 Mar 06 17:47:03 254muzika ntpd[937]: IO: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 06 17:47:03 254muzika ntpd[937]: IO: Listen normally on 2 lo 127.0.0.1:123 Mar 06 17:47:03 254muzika ntpd[937]: IO: Listening on routing socket on fd #19 for interface updates Mar 06 17:47:03 254muzika kernel: cryptd: max_cpu_qlen set to 1000 Mar 06 17:47:03 254muzika ifplugd(eth0)[958]: ifplugd 0.28 initializing. Mar 06 17:47:03 254muzika systemd[1]: Starting systemd-hostnamed.service - Hostname Service... Mar 06 17:47:03 254muzika ifplugd(eth0)[958]: Using interface eth0/B8:27:EB:2A:36:4F with driver (version: 6.12.47-v7+) Mar 06 17:47:03 254muzika systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 06 17:47:03 254muzika ifplugd(eth0)[958]: Using detection mode: SIOCETHTOOL Mar 06 17:47:03 254muzika ifplugd(eth0)[958]: Initialization complete, link beat not detected. Mar 06 17:47:03 254muzika ntpd[937]: INIT: This system has a 32-bit time_t. Mar 06 17:47:03 254muzika ntpd[937]: INIT: This ntpd will fail on 2038-01-19T03:14:07Z. Mar 06 17:47:03 254muzika ntpd[937]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Mar 06 17:47:03 254muzika ntpd[937]: INIT: Built with OpenSSL 3.0.9 30 May 2023, 30000090 Mar 06 17:47:03 254muzika ntpd[937]: INIT: Running with OpenSSL 3.0.18 30 Sep 2025, 30000120 Mar 06 17:47:03 254muzika ntpd[937]: NTSc: Using system default root certificates. Mar 06 17:47:03 254muzika ifplugd[893]: Network Interface Plugging Daemon...start eth0...done. Mar 06 17:47:03 254muzika systemd[1]: Started ifplugd.service - LSB: Brings up/down network automatically. Mar 06 17:47:04 254muzika sshd[965]: Server listening on 0.0.0.0 port 22. Mar 06 17:47:04 254muzika sshd[965]: Server listening on :: port 22. Mar 06 17:47:04 254muzika systemd[1]: Started ssh.service - OpenBSD Secure Shell server. Mar 06 17:47:04 254muzika ntpd[937]: statistics directory /var/log/ntpsec/ does not exist or is unwriteable, error No such file or directory Mar 06 17:47:04 254muzika dbus-daemon[608]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 06 17:47:04 254muzika systemd[1]: Started systemd-hostnamed.service - Hostname Service. Mar 06 17:47:04 254muzika bluetoothd[783]: profiles/audio/bap.c:bap_adapter_probe() BAP requires ISO Socket which is not enabled Mar 06 17:47:04 254muzika bluetoothd[783]: bap: Operation not supported (95) Mar 06 17:47:04 254muzika bluetoothd[783]: Adv Monitor Manager created with supported features:0x00000000, enabled features:0x00000000, max number of supported monitors:32, max number of supported patterns:16 Mar 06 17:47:05 254muzika ntpd[937]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:05 254muzika ntpd[937]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Mar 06 17:47:05 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:05 254muzika ntpd[937]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Mar 06 17:47:05 254muzika bluealsa[928]: ../src/storage.c:90: Initializing persistent storage: /var/lib/bluealsa Mar 06 17:47:05 254muzika bluealsa[928]: main.c:663: Starting main dispatching loop Mar 06 17:47:05 254muzika systemd[1]: Started bluealsa.service - BlueALSA service. Mar 06 17:47:05 254muzika systemd[1]: Reached target bluetooth.target - Bluetooth Support. Mar 06 17:47:05 254muzika bluealsa[928]: main.c:118: Acquired D-Bus service name: org.bluealsa Mar 06 17:47:05 254muzika bluealsa[928]: bluealsa-dbus.c:358: Registering BlueALSA D-Bus manager: /org/bluealsa Mar 06 17:47:05 254muzika bluealsa[928]: bluez.c:153: Registering media application: /org/bluez/hci0 Mar 06 17:47:05 254muzika bluealsa[928]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/1 Mar 06 17:47:05 254muzika bluealsa[928]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/source/2 Mar 06 17:47:05 254muzika bluealsa[928]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/1 Mar 06 17:47:05 254muzika bluealsa[928]: bluez.c:743: Exporting media endpoint object: /org/bluez/hci0/A2DP/SBC/sink/2 Mar 06 17:47:05 254muzika bluetoothd[783]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/1 Mar 06 17:47:05 254muzika bluetoothd[783]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/2 Mar 06 17:47:05 254muzika bluetoothd[783]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/source/2 Mar 06 17:47:05 254muzika bluetoothd[783]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/sink/1 Mar 06 17:47:05 254muzika systemd[1]: samba-ad-dc.service: Skipped due to 'exec-condition'. Mar 06 17:47:05 254muzika systemd[1]: Condition check resulted in samba-ad-dc.service - Samba AD Daemon being skipped. Mar 06 17:47:06 254muzika ntpd[937]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:06 254muzika ntpd[937]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Mar 06 17:47:06 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:06 254muzika ntpd[937]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Mar 06 17:47:06 254muzika nmbd[996]: [2026/03/06 17:47:06.661177, 0] ../../source3/nmbd/nmbd.c:901(main) Mar 06 17:47:06 254muzika nmbd[996]: nmbd version 4.17.8-Raspbian started. Mar 06 17:47:06 254muzika nmbd[996]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Mar 06 17:47:06 254muzika nmbd[996]: [2026/03/06 17:47:06.666585, 0] ../../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 06 17:47:06 254muzika nmbd[996]: started asyncdns process 999 Mar 06 17:47:06 254muzika nmbd[996]: [2026/03/06 17:47:06.668315, 0] ../../lib/util/become_daemon.c:150(daemon_status) Mar 06 17:47:06 254muzika nmbd[996]: daemon_status: daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 06 17:47:06 254muzika nmbd[996]: [2026/03/06 17:47:06.668460, 0] ../../source3/nmbd/nmbd_subnetdb.c:252(create_subnets) Mar 06 17:47:06 254muzika nmbd[996]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 06 17:47:07 254muzika wireless.js[626]: WIRELESS.JS - INFO: Single Network Mode enabled (default) - only one network device can be active at a time between ethernet and wireless Mar 06 17:47:07 254muzika ntpd[937]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:07 254muzika ntpd[937]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Mar 06 17:47:07 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:07 254muzika ntpd[937]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 Mar 06 17:47:07 254muzika wireless.js[626]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Mar 06 17:47:07 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:07] [info] asio async_connect error: asio.system:111 (Connection refused) Mar 06 17:47:07 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:07] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Mar 06 17:47:07 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:07] [error] handle_connect error: Connection refused Mar 06 17:47:07 254muzika systemd[1]: systemd-rfkill.service: Deactivated successfully. Mar 06 17:47:07 254muzika sudo[1020]: root : unable to resolve host 254muzika: System error Mar 06 17:47:07 254muzika sudo[1020]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 06 17:47:07 254muzika sudo[1020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:07 254muzika sudo[1020]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:07 254muzika sudo[1022]: root : unable to resolve host 254muzika: System error Mar 06 17:47:07 254muzika sudo[1022]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 06 17:47:07 254muzika sudo[1022]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:08 254muzika ntpd[937]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:08 254muzika ntpd[937]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Mar 06 17:47:08 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:08 254muzika ntpd[937]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 Mar 06 17:47:08 254muzika sudo[1022]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:08 254muzika wireless.js[626]: WIRELESS.JS - INFO: Cleaning previous... Mar 06 17:47:08 254muzika sudo[1032]: root : unable to resolve host 254muzika: System error Mar 06 17:47:08 254muzika sudo[1032]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 06 17:47:08 254muzika sudo[1032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:08 254muzika sudo[1032]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:08 254muzika kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 06 17:47:08 254muzika wireless.js[626]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Mar 06 17:47:08 254muzika wireless.js[626]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 5ms Mar 06 17:47:08 254muzika wireless.js[626]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:7f:63:1a) Mar 06 17:47:08 254muzika sudo[1039]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:08 254muzika sudo[1039]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 06 17:47:08 254muzika sudo[1039]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:08 254muzika sudo[1039]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:08 254muzika wireless.js[626]: sudo: unable to resolve host 254muzika: System error Mar 06 17:47:08 254muzika sudo[1047]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:08 254muzika sudo[1047]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 06 17:47:08 254muzika sudo[1047]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:11 254muzika sudo[1047]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:11 254muzika wireless.js[626]: sudo: unable to resolve host 254muzika: System error Mar 06 17:47:11 254muzika wireless.js[626]: WIRELESS.JS - INFO: SETTING APPROPRIATE REG DOMAIN: CZ Mar 06 17:47:11 254muzika sudo[1065]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:11 254muzika sudo[1065]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg set CZ Mar 06 17:47:11 254muzika sudo[1065]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:11 254muzika sudo[1065]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:11 254muzika wireless.js[626]: sudo: unable to resolve host 254muzika: System error Mar 06 17:47:11 254muzika wireless.js[626]: WIRELESS.JS - INFO: SUCCESSFULLY SET NEW REGDOMAIN: CZ Mar 06 17:47:11 254muzika wireless.js[626]: WIRELESS.JS - INFO: netconfigured file not found, starting hotspot Mar 06 17:47:11 254muzika wireless.js[626]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Mar 06 17:47:11 254muzika wireless.js[626]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 4ms Mar 06 17:47:11 254muzika sudo[1082]: root : unable to resolve host 254muzika: System error Mar 06 17:47:11 254muzika sudo[1082]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 06 17:47:11 254muzika sudo[1082]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:11 254muzika sudo[1082]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:11 254muzika sudo[1084]: root : unable to resolve host 254muzika: System error Mar 06 17:47:11 254muzika sudo[1084]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 06 17:47:11 254muzika sudo[1084]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:11 254muzika sudo[1084]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:11 254muzika avahi-daemon[607]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 06 17:47:11 254muzika avahi-daemon[607]: New relevant interface wlan0.IPv4 for mDNS. Mar 06 17:47:11 254muzika avahi-daemon[607]: Registering new address record for 192.168.211.1 on wlan0.IPv4. Mar 06 17:47:11 254muzika kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 06 17:47:11 254muzika systemd[1]: welcome.service: Deactivated successfully. Mar 06 17:47:11 254muzika systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 06 17:47:11 254muzika systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 06 17:47:12 254muzika systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 06 17:47:12 254muzika welcome[1091]: Resolved ip:[1] 192.168.211.1 Mar 06 17:47:12 254muzika wireless.js[626]: WIRELESS.JS - INFO: Notified systemd about wireless ready Mar 06 17:47:12 254muzika systemd[1]: Started nmbd.service - Samba NMB Daemon. Mar 06 17:47:12 254muzika systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 06 17:47:12 254muzika systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Mar 06 17:47:12 254muzika kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 06 17:47:12 254muzika systemd[1]: Starting winbind.service - Samba Winbind Daemon... Mar 06 17:47:12 254muzika systemd[1]: Started wireless.service - Wireless Services. Mar 06 17:47:12 254muzika bash[904]: setdatetime-helper: all HTTPS Date fallbacks failed Mar 06 17:47:12 254muzika systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 06 17:47:12 254muzika systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 06 17:47:12 254muzika systemd[1]: setdatetime-helper.service: Consumed 1.363s CPU time. Mar 06 17:47:12 254muzika systemd[1]: Starting hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Mar 06 17:47:12 254muzika systemd[1]: Started volumio.service - Volumio Backend Module. Mar 06 17:47:12 254muzika systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Mar 06 17:47:12 254muzika systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Mar 06 17:47:12 254muzika systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Mar 06 17:47:12 254muzika systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Mar 06 17:47:12 254muzika systemd[1]: Received SIGRTMIN+21 from PID 289 (n/a). Mar 06 17:47:12 254muzika systemd[1]: Received SIGRTMIN+21 from PID 289 (n/a). Mar 06 17:47:12 254muzika systemd[1]: Started getty@tty1.service - Getty on tty1. Mar 06 17:47:12 254muzika systemd[1]: Reached target getty.target - Login Prompts. Mar 06 17:47:12 254muzika volumio-cpu-tweak[1106]: Setting RT Priority for mpd Mar 06 17:47:12 254muzika volumio-cpu-tweak[1121]: pid 35's current scheduling policy: SCHED_OTHER Mar 06 17:47:12 254muzika volumio-cpu-tweak[1121]: pid 35's current scheduling priority: 0 Mar 06 17:47:12 254muzika volumio-cpu-tweak[1106]: Setting MPD Affinity Mar 06 17:47:12 254muzika volumio-cpu-tweak[1122]: pid 3's current affinity mask: f Mar 06 17:47:12 254muzika volumio-cpu-tweak[1106]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Mar 06 17:47:12 254muzika volumio-cpu-tweak[1106]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Mar 06 17:47:12 254muzika dhcpcd[668]: wlan0: carrier acquired Mar 06 17:47:12 254muzika hostapd[1103]: wlan0: interface state UNINITIALIZED->ENABLED Mar 06 17:47:12 254muzika hostapd[1103]: wlan0: AP-ENABLED Mar 06 17:47:12 254muzika systemd[1]: Started hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Mar 06 17:47:12 254muzika systemd[1]: Starting dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Mar 06 17:47:12 254muzika systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Mar 06 17:47:12 254muzika dhcpcd[668]: wlan0: IAID eb:7f:63:1a Mar 06 17:47:12 254muzika dhcpcd[668]: wlan0: adding address fe80::56ae:a799:f020:7611 Mar 06 17:47:12 254muzika dhcpcd[668]: ipv6_addaddr1: Permission denied Mar 06 17:47:12 254muzika dnsmasq[1133]: started, version 2.90 cachesize 150 Mar 06 17:47:12 254muzika dnsmasq[1133]: compile time options: IPv6 GNU-getopt DBus no-UBus i18n IDN2 DHCP DHCPv6 no-Lua TFTP conntrack ipset nftset auth cryptohash DNSSEC loop-detect inotify dumpfile Mar 06 17:47:12 254muzika dnsmasq-dhcp[1133]: DHCP, IP range 192.168.211.100 -- 192.168.211.200, lease time 1d Mar 06 17:47:12 254muzika dnsmasq[1133]: reading /etc/resolv.conf Mar 06 17:47:12 254muzika dnsmasq[1133]: using nameserver 208.67.222.222#53 Mar 06 17:47:12 254muzika dnsmasq[1133]: using nameserver 208.67.220.220#53 Mar 06 17:47:12 254muzika dnsmasq[1133]: read /etc/hosts - 4 names Mar 06 17:47:12 254muzika systemd[1]: Started dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Mar 06 17:47:12 254muzika systemd[1]: Reached target nss-lookup.target - Host and Network Name Lookups. Mar 06 17:47:13 254muzika dhcpcd[668]: wlan0: soliciting an IPv6 router Mar 06 17:47:13 254muzika winbindd[1123]: [2026/03/06 17:47:13.025396, 0] ../../source3/winbindd/winbindd.c:1440(main) Mar 06 17:47:13 254muzika winbindd[1123]: winbindd version 4.17.8-Raspbian started. Mar 06 17:47:13 254muzika winbindd[1123]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Mar 06 17:47:13 254muzika winbindd[1123]: [2026/03/06 17:47:13.061168, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) Mar 06 17:47:13 254muzika winbindd[1123]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 06 17:47:13 254muzika systemd[1]: Started winbind.service - Samba Winbind Daemon. Mar 06 17:47:13 254muzika systemd[1]: Starting smbd.service - Samba SMB Daemon... Mar 06 17:47:13 254muzika systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Mar 06 17:47:13 254muzika systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Mar 06 17:47:13 254muzika systemd[1]: welcome.service: Deactivated successfully. Mar 06 17:47:13 254muzika systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 06 17:47:13 254muzika systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 06 17:47:13 254muzika systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 06 17:47:13 254muzika welcome[1144]: Resolved ip:[1] 192.168.211.1 Mar 06 17:47:13 254muzika systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 06 17:47:13 254muzika systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Mar 06 17:47:13 254muzika smbd[1160]: [2026/03/06 17:47:13.985770, 0] ../../source3/smbd/server.c:1741(main) Mar 06 17:47:13 254muzika smbd[1160]: smbd version 4.17.8-Raspbian started. Mar 06 17:47:13 254muzika smbd[1160]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Mar 06 17:47:14 254muzika ntpd[937]: IO: Listen normally on 3 wlan0 192.168.211.1:123 Mar 06 17:47:14 254muzika ntpd[937]: IO: new interface(s) found: waking up resolver Mar 06 17:47:14 254muzika ntpd[937]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:14 254muzika ntpd[937]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Mar 06 17:47:14 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:14 254muzika ntpd[937]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 Mar 06 17:47:14 254muzika dhcpcd[668]: eth0: carrier acquired Mar 06 17:47:14 254muzika ifplugd(eth0)[958]: Link beat detected. Mar 06 17:47:14 254muzika kernel: lan78xx 1-1.1.1:1.0 eth0: Link is Up - 1Gbps/Full - flow control off Mar 06 17:47:14 254muzika dhcpcd[668]: eth0: IAID eb:2a:36:4f Mar 06 17:47:14 254muzika dhcpcd[668]: eth0: adding address fe80::81d1:30ef:b0cd:5c6c Mar 06 17:47:14 254muzika dhcpcd[668]: ipv6_addaddr1: Permission denied Mar 06 17:47:14 254muzika dhcpcd[668]: eth0: probing address 10.25.4.30/24 Mar 06 17:47:14 254muzika ifplugd(eth0)[958]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Mar 06 17:47:14 254muzika ifplugd(eth0)[958]: client: ifup: interface eth0 already configured Mar 06 17:47:14 254muzika dhcpcd[668]: wlan0: soliciting a DHCP lease Mar 06 17:47:14 254muzika ifplugd(eth0)[958]: Program executed successfully. Mar 06 17:47:14 254muzika dhcpcd[668]: eth0: soliciting an IPv6 router Mar 06 17:47:15 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:14] [info] asio async_connect error: asio.system:111 (Connection refused) Mar 06 17:47:15 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:14] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Mar 06 17:47:15 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:14] [error] handle_connect error: Connection refused Mar 06 17:47:15 254muzika ntpd[937]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:15 254muzika ntpd[937]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Mar 06 17:47:15 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:15 254muzika ntpd[937]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: === SNM TRANSITION === Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: Previous ethernet state: disconnected Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: New ethernet state: connected Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: Single Network Mode: enabled Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: First start: no Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: Action: Switch to ethernet (WiFi scan mode) Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: === END TRANSITION === Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: SNM: Ethernet connected, switching to ethernet (WiFi scan mode) Mar 06 17:47:15 254muzika sudo[1178]: root : unable to resolve host 254muzika: System error Mar 06 17:47:15 254muzika sudo[1178]: root : PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd -k wlan0 Mar 06 17:47:15 254muzika sudo[1178]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:15 254muzika dhcpcd[1179]: dhcpcd not running Mar 06 17:47:15 254muzika sudo[1178]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:15 254muzika wireless.js[626]: sudo: unable to resolve host 254muzika: System error Mar 06 17:47:15 254muzika wireless.js[626]: dhcpcd not running Mar 06 17:47:15 254muzika wireless.js[626]: WIRELESS.JS - INFO: Wireless.js initializing wireless flow Mar 06 17:47:16 254muzika systemd[1]: Started smbd.service - Samba SMB Daemon. Mar 06 17:47:16 254muzika systemd[1]: Reached target multi-user.target - Multi-User System. Mar 06 17:47:16 254muzika systemd[1]: Reached target graphical.target - Graphical Interface. Mar 06 17:47:16 254muzika systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Mar 06 17:47:16 254muzika systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Mar 06 17:47:16 254muzika ntpd[937]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:16 254muzika ntpd[937]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Mar 06 17:47:16 254muzika systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Mar 06 17:47:16 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:16 254muzika systemd[1]: Startup finished in 15.413s (kernel) + 19.847s (userspace) = 35.261s. Mar 06 17:47:16 254muzika ntpd[937]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Mar 06 17:47:16 254muzika systemd[1]: Stopping dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server... Mar 06 17:47:16 254muzika dnsmasq[1133]: exiting on receipt of SIGTERM Mar 06 17:47:16 254muzika systemd[1]: dnsmasq.service: Deactivated successfully. Mar 06 17:47:16 254muzika systemd[1]: Stopped dnsmasq.service - dnsmasq - A lightweight DHCP and caching DNS server. Mar 06 17:47:16 254muzika systemd[1]: Stopping hostapd.service - Access point and authentication server for Wi-Fi and Ethernet... Mar 06 17:47:16 254muzika dhcpcd[668]: wlan0: carrier lost Mar 06 17:47:16 254muzika systemd[1]: hostapd.service: Deactivated successfully. Mar 06 17:47:16 254muzika systemd[1]: Stopped hostapd.service - Access point and authentication server for Wi-Fi and Ethernet. Mar 06 17:47:16 254muzika sudo[1209]: root : unable to resolve host 254muzika: System error Mar 06 17:47:16 254muzika sudo[1209]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 06 17:47:16 254muzika sudo[1209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:16 254muzika avahi-daemon[607]: Withdrawing address record for 192.168.211.1 on wlan0. Mar 06 17:47:16 254muzika avahi-daemon[607]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.211.1. Mar 06 17:47:16 254muzika avahi-daemon[607]: Interface wlan0.IPv4 no longer relevant for mDNS. Mar 06 17:47:16 254muzika sudo[1209]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:16 254muzika systemd[1]: Stopped target ip-changed@wlan0.target - IP Address changed on wlan0. Mar 06 17:47:16 254muzika systemd[1]: Stopping ip-changed@wlan0.target - IP Address changed on wlan0... Mar 06 17:47:16 254muzika systemd[1]: welcome.service: Deactivated successfully. Mar 06 17:47:17 254muzika systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 06 17:47:17 254muzika systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 06 17:47:17 254muzika sudo[1212]: root : unable to resolve host 254muzika: System error Mar 06 17:47:17 254muzika sudo[1212]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 06 17:47:17 254muzika sudo[1212]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:17 254muzika systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 06 17:47:17 254muzika ntpd[937]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:17 254muzika ntpd[937]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Mar 06 17:47:17 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:17 254muzika ntpd[937]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Mar 06 17:47:17 254muzika sudo[1212]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:17 254muzika welcome[1213]: Resolved ip:[0] Mar 06 17:47:17 254muzika wireless.js[626]: WIRELESS.JS - INFO: Cleaning previous... Mar 06 17:47:17 254muzika sudo[1219]: root : unable to resolve host 254muzika: System error Mar 06 17:47:17 254muzika systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 06 17:47:17 254muzika systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Mar 06 17:47:17 254muzika sudo[1219]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 up Mar 06 17:47:17 254muzika sudo[1219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:47:17 254muzika sudo[1219]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:17 254muzika kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 06 17:47:17 254muzika wireless.js[626]: WIRELESS.JS - INFO: InterfaceValidator: READY - wlan0 is ready for operations Mar 06 17:47:17 254muzika wireless.js[626]: WIRELESS.JS - INFO: InterfaceValidator: wlan0 became ready after 2ms Mar 06 17:47:17 254muzika wireless.js[626]: WIRELESS.JS - INFO: ensureInterfaceReady: Interface ready (MAC: b8:27:eb:7f:63:1a) Mar 06 17:47:17 254muzika sudo[1228]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:17 254muzika sudo[1228]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw reg get Mar 06 17:47:17 254muzika sudo[1228]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:17 254muzika sudo[1228]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:17 254muzika wireless.js[626]: sudo: unable to resolve host 254muzika: System error Mar 06 17:47:17 254muzika sudo[1236]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:17 254muzika sudo[1236]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iw wlan0 scan Mar 06 17:47:17 254muzika sudo[1236]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:18 254muzika systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Mar 06 17:47:18 254muzika systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:47:18 254muzika systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:47:18 254muzika upmpdcli[1240]: Could not open config: /tmp/upmpdcli.conf Mar 06 17:47:18 254muzika systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 06 17:47:18 254muzika systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 06 17:47:19 254muzika ntpd[937]: IO: Deleting interface #3 wlan0, 192.168.211.1#123, interface stats: received=0, sent=0, dropped=0, active_time=5 secs Mar 06 17:47:19 254muzika volumio[1104]: info: ------------------------------------------- Mar 06 17:47:19 254muzika volumio[1104]: info: ----- Volumio3 ---- Mar 06 17:47:19 254muzika volumio[1104]: info: ------------------------------------------- Mar 06 17:47:19 254muzika volumio[1104]: info: ----- System startup ---- Mar 06 17:47:19 254muzika volumio[1104]: info: ------------------------------------------- Mar 06 17:47:19 254muzika dhcpcd[668]: eth0: using static address 10.25.4.30/24 Mar 06 17:47:19 254muzika avahi-daemon[607]: Joining mDNS multicast group on interface eth0.IPv4 with address 10.25.4.30. Mar 06 17:47:19 254muzika avahi-daemon[607]: New relevant interface eth0.IPv4 for mDNS. Mar 06 17:47:19 254muzika avahi-daemon[607]: Registering new address record for 10.25.4.30 on eth0.IPv4. Mar 06 17:47:19 254muzika dhcpcd[668]: eth0: adding route to 10.25.4.0/24 Mar 06 17:47:19 254muzika dhcpcd[668]: eth0: adding default route via 10.25.4.1 Mar 06 17:47:19 254muzika systemd[1]: welcome.service: Deactivated successfully. Mar 06 17:47:19 254muzika systemd[1]: Stopped welcome.service - Show a welcome message on console. Mar 06 17:47:19 254muzika systemd[1]: Stopping welcome.service - Show a welcome message on console... Mar 06 17:47:19 254muzika systemd[1]: Starting welcome.service - Show a welcome message on console... Mar 06 17:47:19 254muzika welcome[1266]: Resolved ip:[1] 10.25.4.30 Mar 06 17:47:19 254muzika systemd[1]: Finished welcome.service - Show a welcome message on console. Mar 06 17:47:19 254muzika systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Mar 06 17:47:20 254muzika sudo[1236]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:20 254muzika wireless.js[626]: sudo: unable to resolve host 254muzika: System error Mar 06 17:47:20 254muzika wireless.js[626]: WIRELESS.JS - INFO: Regdomain already correct: CZ Mar 06 17:47:20 254muzika volumio[1104]: info: MYVOLUMIO Environment detected Mar 06 17:47:21 254muzika volumio[1104]: info: Plugin folders cleanup Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning into folder /volumio/app/plugins/ Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning category audio_interface Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning category miscellanea Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning category music_service Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning category plugins.json Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning category system_controller Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning category user_interface Mar 06 17:47:21 254muzika volumio[1104]: info: Scanning into folder /data/plugins/ Mar 06 17:47:21 254muzika volumio[1104]: info: Plugin folders cleanup completed Mar 06 17:47:21 254muzika volumio[1104]: info: ------------------------------------------- Mar 06 17:47:21 254muzika volumio[1104]: info: ----- Core plugins startup ---- Mar 06 17:47:21 254muzika volumio[1104]: info: ------------------------------------------- Mar 06 17:47:21 254muzika volumio[1104]: info: Loading plugins from folder /volumio/app/plugins/ Mar 06 17:47:21 254muzika volumio[1104]: info: Adding plugin upnp to MyMusic Plugins Mar 06 17:47:21 254muzika volumio[1104]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 06 17:47:21 254muzika volumio[1104]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 06 17:47:21 254muzika volumio[1104]: info: Loading plugins from folder /data/plugins/ Mar 06 17:47:21 254muzika volumio[1104]: info: Loading plugin "system"... Mar 06 17:47:21 254muzika volumio[1104]: info: Loading plugin "appearance"... Mar 06 17:47:22 254muzika ntpd[937]: IO: Listen normally on 4 eth0 10.25.4.30:123 Mar 06 17:47:22 254muzika ntpd[937]: IO: new interface(s) found: waking up resolver Mar 06 17:47:22 254muzika ntpd[937]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:23 254muzika volumio[1104]: info: Loading plugin "network"... Mar 06 17:47:23 254muzika volumio[1104]: info: Refreshing Cached IP Addresses Mar 06 17:47:23 254muzika volumio[1104]: info: Loading plugin "services"... Mar 06 17:47:23 254muzika volumio[1104]: info: Loading plugin "volumio5onboarding"... Mar 06 17:47:23 254muzika volumio[1104]: info: Loading plugin "alsa_controller"... Mar 06 17:47:23 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 17:47:23 254muzika volumio[1104]: info: Loading plugin "wizard"... Mar 06 17:47:23 254muzika volumio[1104]: info: Loading plugin "networkfs"... Mar 06 17:47:23 254muzika volumio[1104]: info: Starting Udev Watcher for removable devices Mar 06 17:47:23 254muzika volumio[1104]: info: Ignoring mount for partition: boot Mar 06 17:47:23 254muzika volumio[1104]: info: Ignoring mount for partition: volumio Mar 06 17:47:23 254muzika volumio[1104]: info: Ignoring mount for partition: volumio_data Mar 06 17:47:23 254muzika volumio[1104]: info: Mounting Device MUZIKA_USB Mar 06 17:47:25 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:24] [connect] Successful connection Mar 06 17:47:29 254muzika systemd[1]: systemd-fsckd.service: Deactivated successfully. Mar 06 17:47:32 254muzika ntpd[937]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Mar 06 17:47:32 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:32 254muzika ntpd[937]: DNS: dns_take_status: 3.debian.pool.ntp.org=>error, 12 Mar 06 17:47:33 254muzika ntpd[937]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:33 254muzika systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Mar 06 17:47:33 254muzika systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:47:33 254muzika systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:47:33 254muzika upmpdcli[1317]: Could not open config: /tmp/upmpdcli.conf Mar 06 17:47:33 254muzika systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 06 17:47:33 254muzika systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 06 17:47:34 254muzika systemd[1]: systemd-hostnamed.service: Deactivated successfully. Mar 06 17:47:40 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:40] [connect] Successful connection Mar 06 17:47:44 254muzika ntpd[937]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Mar 06 17:47:44 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:47:44 254muzika ntpd[937]: DNS: dns_take_status: 2.debian.pool.ntp.org=>error, 12 Mar 06 17:47:45 254muzika ntpd[937]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:47:47 254muzika systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Mar 06 17:47:48 254muzika systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Mar 06 17:47:48 254muzika systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:47:48 254muzika systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:47:48 254muzika upmpdcli[1371]: Could not open config: /tmp/upmpdcli.conf Mar 06 17:47:48 254muzika systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 06 17:47:48 254muzika systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 06 17:47:53 254muzika sudo[1315]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:53 254muzika sudo[1279]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:53 254muzika sudo[1288]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:53 254muzika sudo[1279]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 06 17:47:53 254muzika sudo[1279]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:53 254muzika sudo[1281]: volumio : unable to resolve host 254muzika: System error Mar 06 17:47:53 254muzika sudo[1315]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/MUZIKA_USB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 06 17:47:53 254muzika sudo[1281]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 06 17:47:53 254muzika sudo[1315]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:53 254muzika sudo[1281]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:53 254muzika sudo[1288]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 06 17:47:53 254muzika sudo[1288]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:47:53 254muzika sudo[1279]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:53 254muzika sudo[1281]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:53 254muzika kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Mar 06 17:47:54 254muzika kernel: FAT-fs (sda1): Volume was not properly unmounted. Some data may be corrupt. Please run fsck. Mar 06 17:47:54 254muzika sudo[1315]: pam_unix(sudo:session): session closed for user root Mar 06 17:47:54 254muzika volumio[1104]: sudo: unable to resolve host 254muzika: System error Mar 06 17:47:54 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 06 17:47:54 254muzika volumio[1104]: info: Loading plugin "volumio_command_line_client"... Mar 06 17:47:54 254muzika volumio[1104]: info: Loading plugin "upnp"... Mar 06 17:47:54 254muzika volumio[1104]: info: [1772815674120] Starting Upmpd Daemon Mar 06 17:47:54 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 06 17:47:54 254muzika volumio[1104]: info: Loading plugin "my_music"... Mar 06 17:47:54 254muzika volumio[1104]: info: Loading plugin "mpd"... Mar 06 17:47:54 254muzika volumio[1104]: info: Loading plugin "upnp_browser"... Mar 06 17:47:55 254muzika volumio-remote-updater[624]: [2026-03-06 17:47:55] [connect] Successful connection Mar 06 17:47:57 254muzika volumio[1104]: info: Starting UPNP Browser Mar 06 17:47:57 254muzika volumio[1104]: info: Loading plugin "alarm-clock"... Mar 06 17:47:57 254muzika volumio[1104]: info: Loading plugin "airplay_emulation"... Mar 06 17:47:57 254muzika volumio[1104]: info: Starting Shairport Sync Mar 06 17:47:57 254muzika volumio[1104]: info: Loading plugin "last_100"... Mar 06 17:47:57 254muzika volumio[1104]: info: Loading plugin "webradio"... Mar 06 17:47:57 254muzika volumio[1104]: info: Loading plugin "i2s_dacs"... Mar 06 17:47:57 254muzika volumio[1104]: info: I2S DAC not set, start Auto-detection Mar 06 17:47:58 254muzika volumio[1104]: info: Loading plugin "volumiodiscovery"... Mar 06 17:47:58 254muzika volumio[1104]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 06 17:47:58 254muzika volumio[1104]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 17:47:58 254muzika volumio[1104]: *** WARNING *** For more information see Mar 06 17:47:58 254muzika volumio[1104]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 06 17:47:58 254muzika volumio[1104]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 17:47:58 254muzika volumio[1104]: *** WARNING *** For more information see Mar 06 17:47:58 254muzika node[1104]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 06 17:47:58 254muzika node[1104]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 17:47:58 254muzika node[1104]: *** WARNING *** For more information see Mar 06 17:47:58 254muzika node[1104]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 06 17:47:58 254muzika node[1104]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 06 17:47:58 254muzika node[1104]: *** WARNING *** For more information see Mar 06 17:47:58 254muzika volumio[1104]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 06 17:47:58 254muzika volumio[1104]: info: Discovery: Started advertising with name: 254_muzika Mar 06 17:47:58 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 06 17:47:58 254muzika volumio[1104]: info: Loading plugin "outputs"... Mar 06 17:47:58 254muzika volumio[1104]: info: Loading plugin "albumart"... Mar 06 17:47:58 254muzika volumio[1104]: info: Plugin example_plugin is not enabled Mar 06 17:47:58 254muzika volumio[1104]: info: Loading plugin "inputs"... Mar 06 17:47:58 254muzika volumio[1104]: info: Loading plugin "updater_comm"... Mar 06 17:47:58 254muzika volumio[1104]: info: Plugin mpdemulation is not enabled Mar 06 17:47:58 254muzika volumio[1104]: info: Loading plugin "rest_api"... Mar 06 17:47:58 254muzika volumio[1104]: info: Loading plugin "websocket"... Mar 06 17:47:58 254muzika volumio[1104]: info: Starting Socket.io Server version 1.7.4 Mar 06 17:47:58 254muzika volumio[1104]: info: Loading i18n strings for locale cs Mar 06 17:47:58 254muzika volumio[1104]: Updating browse sources language Mar 06 17:47:58 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::initPlayerControls Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 06 17:47:59 254muzika volumio[1104]: Express server listening on port 3000 Mar 06 17:47:59 254muzika volumio[1104]: [Metrics] WebUI: 42s 186.19ms Mar 06 17:47:59 254muzika volumio[1104]: info: CoreStateMachine::resetVolumioState Mar 06 17:47:59 254muzika volumio[1104]: info: CoreStateMachine::getcurrentVolume Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::volumioRetrievevolume Mar 06 17:47:59 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:47:59 254muzika volumio[1400]: Forking 3 albumart workers Mar 06 17:47:59 254muzika volumio[1104]: info: Volumio Network Manager: Network status updated: 1 Mar 06 17:47:59 254muzika sudo[1288]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:01 254muzika volumio[1104]: info: VolumeController:: Volume=86 Mute =false Mar 06 17:48:01 254muzika volumio[1104]: info: CoreStateMachine::pushState Mar 06 17:48:01 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:01 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 17:48:01 254muzika volumio[1104]: info: CoreCommandRouter::volumioPushState Mar 06 17:48:01 254muzika volumio[1104]: info: CoreStateMachine::updateTrackBlock Mar 06 17:48:01 254muzika volumio[1104]: info: CorePlayQueue::getTrackBlock Mar 06 17:48:01 254muzika volumio[1104]: info: CoreCommandRouter::volumioRetrievevolume Mar 06 17:48:01 254muzika volumio[1104]: info: CoreStateMachine::setRepeat true single undefined Mar 06 17:48:01 254muzika volumio[1104]: info: CoreStateMachine::pushState Mar 06 17:48:01 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:01 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 17:48:01 254muzika volumio[1104]: info: CoreCommandRouter::volumioPushState Mar 06 17:48:01 254muzika volumio[1104]: info: CoreStateMachine::setRandom true Mar 06 17:48:01 254muzika volumio[1104]: info: CoreStateMachine::pushState Mar 06 17:48:01 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:01 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 17:48:01 254muzika volumio[1104]: info: CoreCommandRouter::volumioPushState Mar 06 17:48:01 254muzika volumio[1104]: info: Setting Device type: Raspberry PI Mar 06 17:48:02 254muzika volumio[1104]: info: Reloading queue from file Mar 06 17:48:02 254muzika volumio[1104]: info: VolumeController:: Volume=86 Mute =false Mar 06 17:48:02 254muzika volumio[1104]: info: CoreStateMachine::pushState Mar 06 17:48:02 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:02 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 06 17:48:02 254muzika volumio[1104]: info: CoreCommandRouter::volumioPushState Mar 06 17:48:02 254muzika volumio[1104]: info: Completed loading Core Plugins Mar 06 17:48:02 254muzika volumio[1104]: info: Preparing to generate the ALSA configuration file Mar 06 17:48:02 254muzika volumio[1104]: info: Asound.conf file unchanged, so no further update is needed Mar 06 17:48:02 254muzika volumio[1104]: info: Output device has changed, restarting MPD Mar 06 17:48:03 254muzika volumio[1104]: info: Output device has changed, restarting Shairport Sync Mar 06 17:48:03 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:03 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:48:03 254muzika sudo[1465]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:03 254muzika sudo[1465]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 06 17:48:03 254muzika sudo[1465]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:03 254muzika sudo[1463]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:03 254muzika sudo[1463]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 06 17:48:03 254muzika sudo[1463]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:03 254muzika sudo[1463]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:03 254muzika volumio[1104]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 06 17:48:03 254muzika volumio[1104]: info: ___________ START PLUGINS ___________ Mar 06 17:48:03 254muzika systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 06 17:48:03 254muzika systemd[1]: Starting mpd.service - Music Player Daemon... Mar 06 17:48:03 254muzika volumio[1104]: info: ControllerMpd::onStart: Initializing MPD Mar 06 17:48:03 254muzika volumio[1104]: info: Creating MPD Configuration file Mar 06 17:48:03 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 06 17:48:03 254muzika volumio[1104]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 06 17:48:03 254muzika sudo[1475]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:03 254muzika volumio[1104]: info: [1772815683636] CoreMusicLibrary::Adding element Média servery Mar 06 17:48:03 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 17:48:03 254muzika sudo[1474]: root : unable to resolve host 254muzika: System error Mar 06 17:48:03 254muzika sudo[1474]: sudo: unable to resolve host 254muzika: System error Mar 06 17:48:03 254muzika sudo[1474]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 06 17:48:03 254muzika sudo[1474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:48:03 254muzika sudo[1480]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 06 17:48:03 254muzika sudo[1474]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:03 254muzika sudo[1477]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:03 254muzika sudo[1477]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 06 17:48:03 254muzika sudo[1477]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:03 254muzika sudo[1475]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Mar 06 17:48:03 254muzika sudo[1477]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:03 254muzika sudo[1475]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:03 254muzika volumio[1104]: info: UPNP Browser: Client initialized successfully Mar 06 17:48:03 254muzika sudo[1479]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:03 254muzika sudo[1479]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 06 17:48:03 254muzika sudo[1479]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:04 254muzika systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Mar 06 17:48:04 254muzika systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:48:04 254muzika systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:48:04 254muzika systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Mar 06 17:48:04 254muzika sudo[1475]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:04 254muzika upmpdcli[1487]: Could not open config: /tmp/upmpdcli.conf Mar 06 17:48:04 254muzika systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 06 17:48:04 254muzika systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 06 17:48:04 254muzika systemd[1]: mpd.service: Deactivated successfully. Mar 06 17:48:04 254muzika systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 06 17:48:04 254muzika systemd[1]: mpd.socket: Deactivated successfully. Mar 06 17:48:04 254muzika systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 06 17:48:04 254muzika systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 06 17:48:04 254muzika volumio[1104]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 06 17:48:04 254muzika systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 06 17:48:04 254muzika systemd[1]: Starting mpd.service - Music Player Daemon... Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:48:04 254muzika volumio[1104]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 06 17:48:04 254muzika sudo[1510]: root : unable to resolve host 254muzika: System error Mar 06 17:48:04 254muzika sudo[1510]: sudo: unable to resolve host 254muzika: System error Mar 06 17:48:04 254muzika sudo[1510]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 06 17:48:04 254muzika sudo[1510]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 06 17:48:04 254muzika sudo[1516]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 06 17:48:04 254muzika sudo[1510]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 06 17:48:04 254muzika volumio[1104]: info: [1772815684750] CoreMusicLibrary::Adding element Last_100 Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 06 17:48:04 254muzika volumio[1104]: info: [1772815684809] CoreMusicLibrary::Adding element Webradio Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 06 17:48:04 254muzika volumio5-onboarding[1492]: time=2026-03-06T17:48:04.965+01:00 level=INFO msg="running volumio5-device-gateway" version=10ca7e93+CHANGES buildDate=2026-03-06T14:30:20Z Mar 06 17:48:04 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 17:48:04 254muzika volumio[1104]: info: Initializing BBC Radios Mar 06 17:48:05 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 06 17:48:05 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:48:05 254muzika volumio[1104]: info: Volumio Calling Home Mar 06 17:48:08 254muzika ntpd[937]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Mar 06 17:48:08 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:48:08 254muzika ntpd[937]: DNS: dns_take_status: 1.debian.pool.ntp.org=>error, 12 Mar 06 17:48:09 254muzika ntpd[937]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Mar 06 17:48:09 254muzika volumio[1415]: Starting albumart workers Mar 06 17:48:10 254muzika volumio-remote-updater[624]: [2026-03-06 17:48:10] [connect] Successful connection Mar 06 17:48:10 254muzika volumio[1417]: Starting albumart workers Mar 06 17:48:11 254muzika volumio[1416]: Starting albumart workers Mar 06 17:48:12 254muzika mpd[1517]: 2026-03-06T17:48:12 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 06 17:48:12 254muzika systemd[1]: Started mpd.service - Music Player Daemon. Mar 06 17:48:12 254muzika sudo[1479]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:12 254muzika sudo[1465]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:12 254muzika sudo[1546]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:12 254muzika sudo[1546]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 06 17:48:12 254muzika sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:12 254muzika sudo[1546]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:12 254muzika sudo[1548]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:12 254muzika sudo[1548]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 06 17:48:12 254muzika sudo[1548]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:12 254muzika sudo[1548]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:12 254muzika volumio[1104]: info: MPD Permissions set Mar 06 17:48:12 254muzika volumio[1104]: info: Completed starting Core Plugins Mar 06 17:48:12 254muzika volumio[1104]: info: ------------------------------------------- Mar 06 17:48:12 254muzika volumio[1104]: info: ----- MyVolumio plugins startup ---- Mar 06 17:48:12 254muzika volumio[1104]: info: ------------------------------------------- Mar 06 17:48:12 254muzika volumio[1104]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 06 17:48:12 254muzika volumio[1104]: info: MPD Permissions set Mar 06 17:48:13 254muzika volumio[1104]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Mar 06 17:48:13 254muzika volumio[1104]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Mar 06 17:48:13 254muzika volumio[1104]: info: Received Get System Info Mar 06 17:48:13 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 17:48:13 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 17:48:13 254muzika volumio[1104]: info: Discovery: Getting this device information Mar 06 17:48:13 254muzika volumio[1104]: info: CoreCommandRouter::volumioGetState Mar 06 17:48:13 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:13 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 17:48:13 254muzika volumio5-onboarding[1492]: time=2026-03-06T17:48:13.580+01:00 level=INFO msg="system info for 6b64e514281cd98e63b5c85e41f0b51b" deviceName=254_muzika deviceVariant=volumio deviceModel= softwareVersion=4.103 Mar 06 17:48:14 254muzika volumio[1104]: error: MPD error: The expression evaluated to a falsy value: Mar 06 17:48:14 254muzika volumio[1104]: assert.ok(self.idling) Mar 06 17:48:14 254muzika volumio[1104]: error: The expression evaluated to a falsy value: Mar 06 17:48:14 254muzika volumio[1104]: assert.ok(self.idling) Mar 06 17:48:14 254muzika volumio-remote-updater[624]: [2026-03-06 17:48:14] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1772815690 101 Mar 06 17:48:14 254muzika volumio[1104]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 2 Mar 06 17:48:14 254muzika volumio[1104]: info: MPD running with PID1517 Mar 06 17:48:14 254muzika volumio[1104]: ,establishing connection Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:14 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:15 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:48:15 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:15 254muzika volumio[1104]: error: updateQueue error: null Mar 06 17:48:15 254muzika volumio[1104]: error: updateQueue error: null Mar 06 17:48:15 254muzika volumio[1104]: info: Starting Shairport Sync Mar 06 17:48:15 254muzika volumio[1104]: info: Starting Shairport Sync Mar 06 17:48:15 254muzika volumio[1104]: info: Starting Shairport Sync Mar 06 17:48:18 254muzika volumio5-onboarding[1492]: time=2026-03-06T17:48:18.586+01:00 level=INFO msg="bootstrapping state" hasInternet=false Mar 06 17:48:18 254muzika volumio[1104]: info: Received Get System Info Mar 06 17:48:18 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 06 17:48:18 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 06 17:48:18 254muzika volumio[1104]: info: Discovery: Getting this device information Mar 06 17:48:18 254muzika volumio[1104]: info: CoreCommandRouter::volumioGetState Mar 06 17:48:18 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:18 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 06 17:48:18 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 06 17:48:18 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 06 17:48:18 254muzika volumio5-onboarding[1492]: time=2026-03-06T17:48:18.727+01:00 level=INFO msg="enabling local network discovery" Mar 06 17:48:18 254muzika volumio5-onboarding[1492]: time=2026-03-06T17:48:18.756+01:00 level=INFO msg="enabling BLE discovery" Mar 06 17:48:19 254muzika systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Mar 06 17:48:19 254muzika systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:48:19 254muzika systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 06 17:48:19 254muzika volumio5-onboarding[1492]: time=2026-03-06T17:48:19.645+01:00 level=INFO msg="service successfully established" component=discovery/localnet Mar 06 17:48:23 254muzika bash[1351]: setdatetime-helper: all HTTPS Date fallbacks failed Mar 06 17:48:23 254muzika systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 06 17:48:23 254muzika systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 06 17:48:28 254muzika nmbd[996]: [2026/03/06 17:48:28.268364, 0] ../../source3/libsmb/nmblib.c:923(send_udp) Mar 06 17:48:28 254muzika nmbd[996]: Packet send failed to 192.168.211.255(138) ERRNO=Network is unreachable Mar 06 17:48:29 254muzika sudo[1593]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:29 254muzika sudo[1593]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 06 17:48:29 254muzika sudo[1593]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:29 254muzika sudo[1600]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:29 254muzika sudo[1604]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:29 254muzika sudo[1604]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 06 17:48:29 254muzika sudo[1604]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:29 254muzika sudo[1602]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:29 254muzika sudo[1602]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 06 17:48:29 254muzika sudo[1602]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:29 254muzika sudo[1600]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 06 17:48:29 254muzika sudo[1600]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 06 17:48:29 254muzika sudo[1593]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:29 254muzika volumio[1104]: info: Upmpdcli Daemon Started Mar 06 17:48:29 254muzika systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Mar 06 17:48:29 254muzika systemd[1]: shairport-sync.service: Deactivated successfully. Mar 06 17:48:29 254muzika systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 06 17:48:29 254muzika systemd[1]: shairport-sync.service: Consumed 1.912s CPU time. Mar 06 17:48:29 254muzika systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Mar 06 17:48:29 254muzika sudo[1600]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:29 254muzika sudo[1604]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:29 254muzika sudo[1602]: pam_unix(sudo:session): session closed for user root Mar 06 17:48:29 254muzika volumio[1104]: info: Shairport-Sync Started Mar 06 17:48:29 254muzika volumio[1104]: Error adding Membership: Error: addMembership EINVAL Mar 06 17:48:29 254muzika volumio[1104]: info: Shairport-Sync Started Mar 06 17:48:29 254muzika volumio[1104]: info: Shairport-Sync Started Mar 06 17:48:32 254muzika ntpd[937]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Mar 06 17:48:32 254muzika ntpd[937]: DNS: dns_check: DNS error: -11, System error Mar 06 17:48:32 254muzika ntpd[937]: DNS: dns_take_status: 0.debian.pool.ntp.org=>error, 12 Mar 06 17:48:32 254muzika volumio[1104]: error: MyVolumio Plugin failed to start in a timely fashion Mar 06 17:48:32 254muzika volumio[1104]: [Metrics] CommandRouter: 73s 773.99ms Mar 06 17:48:32 254muzika volumio[1104]: info: CoreCommandRouter::volumiosetStartupVolume Mar 06 17:48:32 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 06 17:48:32 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 06 17:48:33 254muzika volumio[1104]: info: CoreCommandRouter::Close All Modals sent Mar 06 17:48:33 254muzika volumio[1104]: info: CoreCommandRouter::Close All Modals sent Mar 06 17:48:34 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 06 17:48:34 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 06 17:48:34 254muzika volumio[1104]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 06 17:48:34 254muzika volumio[1104]: info: Discovery: adding 40a7c918-d997-4751-a1d3-54f74a7bb8b5 Mar 06 17:48:34 254muzika volumio[1104]: info: Discovery: Found device 254_muzika Mar 06 17:48:34 254muzika volumio[1104]: info: CoreCommandRouter::volumioGetState Mar 06 17:48:34 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:34 254muzika volumio[1104]: info: Discovery: this is already registered, 40a7c918-d997-4751-a1d3-54f74a7bb8b5 Mar 06 17:48:34 254muzika volumio[1104]: info: Discovery: Found device 254_muzika Mar 06 17:48:34 254muzika volumio[1104]: info: CoreCommandRouter::volumioGetState Mar 06 17:48:34 254muzika volumio[1104]: info: CorePlayQueue::getTrack 0 Mar 06 17:48:35 254muzika volumio[1104]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 06 17:48:35 254muzika volumio[1104]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 06 17:48:35 254muzika volumio[1104]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals. Mar 06 17:48:35 254muzika volumio[1104]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues Mar 06 17:48:35 254muzika volumio[1104]: at new NodeError (node:internal/errors:405:5) Mar 06 17:48:35 254muzika volumio[1104]: at assert (node:internal/assert:14:11) Mar 06 17:48:35 254muzika volumio[1104]: at internalConnectMultiple (node:net:1118:3) Mar 06 17:48:35 254muzika volumio[1104]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3) Mar 06 17:48:35 254muzika volumio[1104]: at listOnTimeout (node:internal/timers:575:11) Mar 06 17:48:35 254muzika volumio[1104]: at process.processTimers (node:internal/timers:514:7) { Mar 06 17:48:35 254muzika volumio[1104]: code: 'ERR_INTERNAL_ASSERTION' Mar 06 17:48:35 254muzika volumio[1104]: } Mar 06 17:48:35 254muzika volumio[1104]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 06 17:48:40 254muzika upmpdcli[1700]: writing RSA key Mar 06 17:48:56 254muzika sudo[1706]: volumio : unable to resolve host 254muzika: System error Mar 06 17:48:56 254muzika sudo[1706]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-06 17:47' Mar 06 17:48:56 254muzika sudo[1706]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"