Dec 16 12:28:01 volumio wireless.js[952]: INFO: Start ap Dec 16 12:28:01 volumio wireless.js[952]: INFO: Notified systemd about wireless ready Dec 16 12:28:01 volumio systemd[1]: Started wireless.service - Wireless Services. Dec 16 12:28:01 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Dec 16 12:28:01 volumio systemd[1]: Started display-reporter.service - Servicio de Pantalla Volumio ESP32. Dec 16 12:28:01 volumio systemd[1]: Started screenshot.service - Process screenshots triggered by PrtSc-button. Dec 16 12:28:01 volumio systemd[1]: Started soundcard-init.service - Intel SST and HDA soundcard init service. Dec 16 12:28:01 volumio systemd[1]: Started volumio-kiosk.service - Start Volumio Kiosk. Dec 16 12:28:01 volumio systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Dec 16 12:28:01 volumio volumio-cpu-tweak[1565]: Setting RT Priority for mpd Dec 16 12:28:01 volumio volumio-cpu-tweak[1585]: pid 35's current scheduling policy: SCHED_OTHER Dec 16 12:28:01 volumio volumio-cpu-tweak[1585]: pid 35's current scheduling priority: 0 Dec 16 12:28:01 volumio volumio-cpu-tweak[1565]: Setting MPD Affinity Dec 16 12:28:01 volumio volumio-cpu-tweak[1597]: pid 3's current affinity mask: f Dec 16 12:28:01 volumio volumio-cpu-tweak[1565]: VOLUMIO CPU TWEAK: Setting CPU Governor: performance Dec 16 12:28:01 volumio systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Dec 16 12:28:02 volumio soundcard-init.sh[1628]: Card 0 Chip Conexant Generic Name HDA Intel PCH Dec 16 12:28:02 volumio soundcard-init.sh[1650]: Simple mixer control 'Master',0 Dec 16 12:28:02 volumio soundcard-init.sh[1650]: Capabilities: pvolume pswitch Dec 16 12:28:02 volumio soundcard-init.sh[1650]: Playback channels: Front Left - Front Right Dec 16 12:28:02 volumio soundcard-init.sh[1650]: Limits: Playback 0 - 74 Dec 16 12:28:02 volumio soundcard-init.sh[1650]: Mono: Dec 16 12:28:02 volumio soundcard-init.sh[1650]: Front Left: Playback 56 [76%] [-18.00dB] [on] Dec 16 12:28:02 volumio soundcard-init.sh[1650]: Front Right: Playback 56 [76%] [-18.00dB] [on] Dec 16 12:28:02 volumio systemd[1]: soundcard-init.service: Deactivated successfully. Dec 16 12:28:02 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:02 volumio dhcpcd[965]: eth0: leased 192.168.0.107 for 86400 seconds Dec 16 12:28:02 volumio dhcpcd[965]: eth0: adding route to 192.168.0.0/24 Dec 16 12:28:02 volumio dhcpcd[965]: eth0: adding default route via 192.168.0.1 Dec 16 12:28:02 volumio avahi-daemon[936]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.107. Dec 16 12:28:02 volumio avahi-daemon[936]: New relevant interface eth0.IPv4 for mDNS. Dec 16 12:28:02 volumio avahi-daemon[936]: Registering new address record for 192.168.0.107 on eth0.IPv4. Dec 16 12:28:02 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 16 12:28:02 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 16 12:28:02 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 16 12:28:02 volumio sudo[1660]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:02 volumio sudo[1660]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:02 volumio sudo[1660]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:02 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 16 12:28:02 volumio welcome[1663]: Resolved ip:[1] 192.168.0.107 Dec 16 12:28:02 volumio sudo[1679]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:02 volumio sudo[1679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:02 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 16 12:28:02 volumio sudo[1679]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:02 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 16 12:28:02 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Dec 16 12:28:02 volumio startx[1643]: X.Org X Server 1.21.1.7 Dec 16 12:28:02 volumio startx[1643]: X Protocol Version 11, Revision 0 Dec 16 12:28:02 volumio startx[1643]: Current Operating System: Linux volumio 6.12.57-volumio #2 SMP PREEMPT_DYNAMIC Thu Nov 13 17:08:37 CET 2025 x86_64 Dec 16 12:28:02 volumio startx[1643]: Kernel command line: BOOT_IMAGE=/vmlinuz initramfs.clear splash plymouth.ignore-serial-consoles quiet loglevel=0 bootdelay=5 biosdevname=0 imgpart=UUID=4778dbaf-3ab3-4897-a88e-b4d49b33f630 bootpart=UUID=94D8-9758 datapart=UUID=62739e82-a0ed-413c-b9ad-ea85685b8290 hwdevice=x86 uuidconfig=syslinux.cfg,efi/BOOT/grub.cfg imgfile=/volumio_current.sqsh logo.nologo vt.global_cursor_default=0 acpi_backlight=native net.ifnames=0 use_kmsg=no Dec 16 12:28:02 volumio startx[1643]: xorg-server 2:21.1.7-3+deb12u10 (https://www.debian.org/support) Dec 16 12:28:02 volumio startx[1643]: Current version of pixman: 0.42.2 Dec 16 12:28:02 volumio startx[1643]: Before reporting problems, check http://wiki.x.org Dec 16 12:28:02 volumio startx[1643]: to make sure that you have the latest version. Dec 16 12:28:02 volumio startx[1643]: Markers: (--) probed, (**) from config file, (==) default setting, Dec 16 12:28:02 volumio startx[1643]: (++) from command line, (!!) notice, (II) informational, Dec 16 12:28:02 volumio startx[1643]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Dec 16 12:28:02 volumio startx[1643]: (==) Log file: "/var/log/Xorg.0.log", Time: Tue Dec 16 12:28:02 2025 Dec 16 12:28:02 volumio startx[1643]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Dec 16 12:28:02 volumio systemd[1]: Started nmbd.service - Samba NMB Daemon. Dec 16 12:28:02 volumio systemd[1]: Starting winbind.service - Samba Winbind Daemon... Dec 16 12:28:03 volumio dhcpcd[943]: eth0: leased 192.168.0.107 for 86400 seconds Dec 16 12:28:03 volumio sh[920]: eth0: leased 192.168.0.107 for 86400 seconds Dec 16 12:28:03 volumio sh[920]: eth0: adding route to 192.168.0.0/24 Dec 16 12:28:03 volumio dhcpcd[943]: eth0: adding route to 192.168.0.0/24 Dec 16 12:28:03 volumio sh[920]: eth0: adding default route via 192.168.0.1 Dec 16 12:28:03 volumio dhcpcd[943]: eth0: adding default route via 192.168.0.1 Dec 16 12:28:03 volumio systemd[1]: Stopped target ip-changed@eth0.target - IP Address changed on eth0. Dec 16 12:28:03 volumio systemd[1]: Stopping ip-changed@eth0.target - IP Address changed on eth0... Dec 16 12:28:03 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 16 12:28:03 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 16 12:28:03 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 16 12:28:03 volumio sh[920]: forked to background, child pid 942 Dec 16 12:28:03 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 16 12:28:03 volumio winbindd[1694]: [2025/12/16 12:28:03.272892, 0] ../../source3/winbindd/winbindd.c:1440(main) Dec 16 12:28:03 volumio welcome[1701]: Resolved ip:[1] 192.168.0.107 Dec 16 12:28:03 volumio winbindd[1694]: winbindd version 4.17.12-Debian started. Dec 16 12:28:03 volumio winbindd[1694]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 16 12:28:03 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 16 12:28:03 volumio systemd[1]: Reached target ip-changed@eth0.target - IP Address changed on eth0. Dec 16 12:28:03 volumio dhcpcd[965]: wlan0: offered 192.168.0.162 from 192.168.0.1 Dec 16 12:28:03 volumio dhcpcd[965]: wlan0: probing address 192.168.0.162/24 Dec 16 12:28:03 volumio winbindd[1694]: [2025/12/16 12:28:03.360076, 0] ../../source3/winbindd/winbindd_cache.c:3117(initialize_winbindd_cache) Dec 16 12:28:03 volumio winbindd[1694]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Dec 16 12:28:03 volumio ifplugd(eth0)[1231]: client: ifup: interface eth0 already configured Dec 16 12:28:03 volumio sh[1750]: eth0=eth0 Dec 16 12:28:03 volumio systemd[1]: Started winbind.service - Samba Winbind Daemon. Dec 16 12:28:03 volumio systemd[1]: Starting smbd.service - Samba SMB Daemon... Dec 16 12:28:03 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:03 volumio sudo[1766]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:03 volumio sudo[1766]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:03 volumio sudo[1766]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:03 volumio ifplugd(eth0)[1231]: Program executed successfully. Dec 16 12:28:03 volumio sudo[1771]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:03 volumio sudo[1771]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:03 volumio sudo[1771]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:03 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Dec 16 12:28:03 volumio smbd[1769]: [2025/12/16 12:28:03.848040, 0] ../../source3/smbd/server.c:1741(main) Dec 16 12:28:03 volumio smbd[1769]: smbd version 4.17.12-Debian started. Dec 16 12:28:03 volumio smbd[1769]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Dec 16 12:28:04 volumio systemd[1]: Started smbd.service - Samba SMB Daemon. Dec 16 12:28:04 volumio systemd[1]: Reached target multi-user.target - Multi-User System. Dec 16 12:28:04 volumio systemd[1]: Reached target graphical.target - Graphical Interface. Dec 16 12:28:04 volumio systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Dec 16 12:28:04 volumio systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Dec 16 12:28:04 volumio systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Dec 16 12:28:04 volumio systemd[1]: Startup finished in 6.339s (firmware) + 2.455s (loader) + 17.675s (kernel) + 35.596s (userspace) = 1min 2.066s. Dec 16 12:28:04 volumio wireless.js[952]: INFO: WARNING: dhcpcd running but no IP assigned yet Dec 16 12:28:04 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:04 volumio sudo[1804]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:04 volumio sudo[1804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:04 volumio sudo[1804]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:04 volumio sudo[1807]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:04 volumio sudo[1807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:04 volumio sudo[1807]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:04 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Dec 16 12:28:04 volumio ntpd[1199]: IO: Listen normally on 3 eth0 192.168.0.107:123 Dec 16 12:28:04 volumio ntpd[1199]: IO: new interface(s) found: waking up resolver Dec 16 12:28:04 volumio ntpd[1199]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:04 volumio ntpd[1199]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Dec 16 12:28:04 volumio ntpd[1199]: DNS: Pool taking: 170.210.222.10 Dec 16 12:28:04 volumio ntpd[1199]: DNS: Pool taking: 162.159.200.123 Dec 16 12:28:04 volumio ntpd[1199]: DNS: Pool taking: 162.159.200.1 Dec 16 12:28:04 volumio ntpd[1199]: DNS: Pool taking: 168.96.251.195 Dec 16 12:28:04 volumio ntpd[1199]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Dec 16 12:28:05 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:05 volumio sudo[1820]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:05 volumio sudo[1820]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:05 volumio sudo[1820]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:05 volumio sudo[1823]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:05 volumio sudo[1823]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:05 volumio sudo[1823]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:05 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Dec 16 12:28:05 volumio ntpd[1199]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:05 volumio startx[1643]: MESA: warning: Driver does not support the 0x46d4 PCI ID. Dec 16 12:28:05 volumio startx[1643]: MESA: warning: Driver does not support the 0x46d4 PCI ID. Dec 16 12:28:06 volumio ntpd[1199]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 168.96.251.195 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 170.210.222.10 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.123 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.1 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool taking: 2606:4700:f1::123 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool taking: 2606:4700:f1::1 Dec 16 12:28:06 volumio ntpd[1199]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Dec 16 12:28:06 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:06 volumio sudo[1845]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:06 volumio sudo[1845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:06 volumio sudo[1845]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:06 volumio sudo[1854]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:06 volumio sudo[1854]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:06 volumio sudo[1854]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:06 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Dec 16 12:28:06 volumio volumio[1559]: info: ------------------------------------------- Dec 16 12:28:06 volumio volumio[1559]: info: ----- Volumio3 ---- Dec 16 12:28:06 volumio volumio[1559]: info: ------------------------------------------- Dec 16 12:28:06 volumio volumio[1559]: info: ----- System startup ---- Dec 16 12:28:06 volumio volumio[1559]: info: ------------------------------------------- Dec 16 12:28:06 volumio ntpd[1199]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:06 volumio ntpd[1199]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.123 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 170.210.222.10 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.1 Dec 16 12:28:06 volumio ntpd[1199]: DNS: Pool skipping: 168.96.251.195 Dec 16 12:28:06 volumio ntpd[1199]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 16 12:28:06 volumio volumio-remote-updater[950]: [2025-12-16 12:28:06] [connect] Successful connection Dec 16 12:28:07 volumio volumio[1559]: info: MYVOLUMIO Environment detected Dec 16 12:28:07 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:07 volumio sudo[1879]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:07 volumio sudo[1879]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:07 volumio sudo[1879]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:07 volumio sudo[1886]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:07 volumio sudo[1886]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:07 volumio sudo[1886]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:07 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Dec 16 12:28:07 volumio ntpd[1199]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:07 volumio ntpd[1199]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 16 12:28:07 volumio ntpd[1199]: DNS: Pool skipping: 168.96.251.195 Dec 16 12:28:07 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.123 Dec 16 12:28:07 volumio ntpd[1199]: DNS: Pool skipping: 170.210.222.10 Dec 16 12:28:07 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.1 Dec 16 12:28:07 volumio ntpd[1199]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 16 12:28:08 volumio volumio[1559]: info: Plugin folders cleanup Dec 16 12:28:08 volumio volumio[1559]: info: Scanning into folder /volumio/app/plugins/ Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category audio_interface Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category miscellanea Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category music_service Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category plugins.json Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category system_controller Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category user_interface Dec 16 12:28:08 volumio volumio[1559]: info: Scanning into folder /data/plugins/ Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category music_service Dec 16 12:28:08 volumio volumio[1559]: info: Scanning category system_controller Dec 16 12:28:08 volumio volumio[1559]: info: Plugin folders cleanup completed Dec 16 12:28:08 volumio volumio[1559]: info: ------------------------------------------- Dec 16 12:28:08 volumio volumio[1559]: info: ----- Core plugins startup ---- Dec 16 12:28:08 volumio volumio[1559]: info: ------------------------------------------- Dec 16 12:28:08 volumio volumio[1559]: info: Loading plugins from folder /volumio/app/plugins/ Dec 16 12:28:08 volumio volumio[1559]: info: Adding plugin upnp to MyMusic Plugins Dec 16 12:28:08 volumio volumio[1559]: info: Adding plugin airplay_emulation to MyMusic Plugins Dec 16 12:28:08 volumio volumio[1559]: info: Adding plugin upnp_browser to MyMusic Plugins Dec 16 12:28:08 volumio volumio[1559]: info: Loading plugins from folder /data/plugins/ Dec 16 12:28:08 volumio volumio[1559]: info: Loading plugin "system"... Dec 16 12:28:08 volumio volumio[1559]: info: Loading plugin "appearance"... Dec 16 12:28:08 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:08 volumio sudo[1909]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:08 volumio sudo[1909]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:08 volumio sudo[1909]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:08 volumio sudo[1912]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:08 volumio sudo[1912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:08 volumio sudo[1912]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:08 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Dec 16 12:28:08 volumio dhcpcd[965]: wlan0: leased 192.168.0.162 for 86400 seconds Dec 16 12:28:08 volumio avahi-daemon[936]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.162. Dec 16 12:28:08 volumio avahi-daemon[936]: New relevant interface wlan0.IPv4 for mDNS. Dec 16 12:28:08 volumio avahi-daemon[936]: Registering new address record for 192.168.0.162 on wlan0.IPv4. Dec 16 12:28:08 volumio dhcpcd[965]: wlan0: adding route to 192.168.0.0/24 Dec 16 12:28:08 volumio dhcpcd[965]: wlan0: adding default route via 192.168.0.1 Dec 16 12:28:08 volumio systemd[1]: welcome.service: Deactivated successfully. Dec 16 12:28:08 volumio systemd[1]: Stopped welcome.service - Show a welcome message on console. Dec 16 12:28:08 volumio systemd[1]: Stopping welcome.service - Show a welcome message on console... Dec 16 12:28:08 volumio systemd[1]: Starting welcome.service - Show a welcome message on console... Dec 16 12:28:08 volumio welcome[1934]: Resolved ip:[2] 192.168.0.107 192.168.0.162 Dec 16 12:28:08 volumio systemd[1]: Finished welcome.service - Show a welcome message on console. Dec 16 12:28:08 volumio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Dec 16 12:28:09 volumio wireless.js[952]: INFO: trying... Dec 16 12:28:09 volumio sudo[1994]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Dec 16 12:28:09 volumio sudo[1994]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:09 volumio sudo[1994]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:09 volumio sudo[1997]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:09 volumio sudo[1997]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:09 volumio sudo[1997]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:09 volumio wireless.js[952]: INFO: ... wlan0 IPv4 is 192.168.0.162, ipV6 is undefined Dec 16 12:28:09 volumio wireless.js[952]: INFO: Connected to SSID: GOD SAVE THE QUEEN 2.4GHz Dec 16 12:28:09 volumio wireless.js[952]: INFO: It's done! AP Dec 16 12:28:09 volumio wireless.js[952]: INFO: Restarting avahi-daemon... Dec 16 12:28:09 volumio sudo[2002]: root : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart avahi-daemon Dec 16 12:28:09 volumio sudo[2002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:09 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 16 12:28:09 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 16 12:28:09 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 12:28:09 volumio systemd[1]: shairport-sync.service: Consumed 2.041s CPU time. Dec 16 12:28:09 volumio avahi-daemon[936]: Got SIGTERM, quitting. Dec 16 12:28:09 volumio avahi-daemon[936]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 16 12:28:09 volumio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 16 12:28:09 volumio avahi-daemon[936]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.107. Dec 16 12:28:09 volumio avahi-daemon[936]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.162. Dec 16 12:28:09 volumio dbus-daemon[938]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' requested by ':1.16' (uid=0 pid=1769 comm="/usr/sbin/smbd --foreground --no-process-group") Dec 16 12:28:09 volumio avahi-daemon[936]: avahi-daemon 0.8 exiting. Dec 16 12:28:09 volumio systemd[1]: avahi-daemon.service: Deactivated successfully. Dec 16 12:28:09 volumio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 16 12:28:09 volumio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Dec 16 12:28:09 volumio avahi-daemon[2004]: Process 936 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Dec 16 12:28:09 volumio avahi-daemon[2004]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Dec 16 12:28:09 volumio avahi-daemon[2004]: Successfully dropped root privileges. Dec 16 12:28:09 volumio avahi-daemon[2004]: avahi-daemon 0.8 starting up. Dec 16 12:28:09 volumio dbus-daemon[938]: [system] Successfully activated service 'org.freedesktop.Avahi' Dec 16 12:28:09 volumio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Dec 16 12:28:09 volumio avahi-daemon[2004]: Successfully called chroot(). Dec 16 12:28:09 volumio avahi-daemon[2004]: Successfully dropped remaining capabilities. Dec 16 12:28:09 volumio avahi-daemon[2004]: No service file found in /etc/avahi/services. Dec 16 12:28:09 volumio avahi-daemon[2004]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.162. Dec 16 12:28:09 volumio avahi-daemon[2004]: New relevant interface wlan0.IPv4 for mDNS. Dec 16 12:28:09 volumio avahi-daemon[2004]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.107. Dec 16 12:28:09 volumio avahi-daemon[2004]: New relevant interface eth0.IPv4 for mDNS. Dec 16 12:28:09 volumio avahi-daemon[2004]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Dec 16 12:28:09 volumio avahi-daemon[2004]: New relevant interface lo.IPv4 for mDNS. Dec 16 12:28:09 volumio avahi-daemon[2004]: Network interface enumeration completed. Dec 16 12:28:09 volumio avahi-daemon[2004]: Registering new address record for 192.168.0.162 on wlan0.IPv4. Dec 16 12:28:09 volumio avahi-daemon[2004]: Registering new address record for 192.168.0.107 on eth0.IPv4. Dec 16 12:28:09 volumio avahi-daemon[2004]: Registering new address record for 127.0.0.1 on lo.IPv4. Dec 16 12:28:09 volumio sudo[2002]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:09 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 12:28:09 volumio wireless.js[952]: INFO: Notified systemd about wireless ready Dec 16 12:28:10 volumio avahi-daemon[2004]: Server startup complete. Host name is volumio.local. Local service cookie is 3452403788. Dec 16 12:28:10 volumio ntpd[1199]: IO: Listen normally on 4 wlan0 192.168.0.162:123 Dec 16 12:28:10 volumio ntpd[1199]: IO: new interface(s) found: waking up resolver Dec 16 12:28:10 volumio ntpd[1199]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:10 volumio ntpd[1199]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Dec 16 12:28:10 volumio ntpd[1199]: DNS: Pool skipping: 170.210.222.10 Dec 16 12:28:10 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.123 Dec 16 12:28:10 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.1 Dec 16 12:28:10 volumio ntpd[1199]: DNS: Pool skipping: 168.96.251.195 Dec 16 12:28:10 volumio ntpd[1199]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Dec 16 12:28:12 volumio ntpd[1199]: CLOCK: time stepped by 2.172916 Dec 16 12:28:12 volumio ntpd[1199]: INIT: MRU 10922 entries, 13 hash bits, 65536 bytes Dec 16 12:28:12 volumio systemd[1]: Starting e2scrub_all.service - Online ext4 Metadata Check for All Filesystems... Dec 16 12:28:12 volumio systemd[1]: e2scrub_all.service: Deactivated successfully. Dec 16 12:28:12 volumio systemd[1]: Finished e2scrub_all.service - Online ext4 Metadata Check for All Filesystems. Dec 16 12:28:13 volumio systemd[1]: systemd-fsckd.service: Deactivated successfully. Dec 16 12:28:13 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Dec 16 12:28:13 volumio ntpd[1199]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:13 volumio ntpd[1199]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Dec 16 12:28:13 volumio ntpd[1199]: DNS: Pool skipping: 168.96.251.195 Dec 16 12:28:13 volumio ntpd[1199]: DNS: Pool skipping: 170.210.222.10 Dec 16 12:28:13 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.123 Dec 16 12:28:13 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.1 Dec 16 12:28:13 volumio ntpd[1199]: DNS: Pool skipping: 2606:4700:f1::123 Dec 16 12:28:13 volumio ntpd[1199]: DNS: Pool skipping: 2606:4700:f1::1 Dec 16 12:28:13 volumio ntpd[1199]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "network"... Dec 16 12:28:14 volumio volumio[1559]: info: Refreshing Cached IP Addresses Dec 16 12:28:14 volumio sudo[2073]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 12:28:14 volumio sudo[2073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:14 volumio sudo[2076]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:14 volumio sudo[2076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:14 volumio sudo[2073]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "services"... Dec 16 12:28:14 volumio sudo[2076]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:14 volumio sudo[2082]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Dec 16 12:28:14 volumio sudo[2082]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "alsa_controller"... Dec 16 12:28:14 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Dec 16 12:28:14 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Dec 16 12:28:14 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "wizard"... Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "networkfs"... Dec 16 12:28:14 volumio volumio[1559]: info: Starting Udev Watcher for removable devices Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: boot Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: volumio Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: volumio_data Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: BE18-421F Dec 16 12:28:14 volumio volumio[1559]: error: Cannot associate FS Label, not mounting Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: 7CFE1952FE1905D4 Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: F08095B5809582B0 Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: 544e5c35-d28e-4eb3-918f-d73cb6d13c65 Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: 95440bfe-4962-4298-9089-9396a85a1ecf Dec 16 12:28:14 volumio volumio[1559]: info: Ignoring mount for partition: 1b7b3370-99fd-443c-a266-c0a41d755a1e Dec 16 12:28:14 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "volumio_command_line_client"... Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "upnp"... Dec 16 12:28:14 volumio volumio[1559]: info: [1765898894893] Starting Upmpd Daemon Dec 16 12:28:14 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "my_music"... Dec 16 12:28:14 volumio volumio[1559]: info: Loading plugin "mpd"... Dec 16 12:28:14 volumio ntpd[1199]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:14 volumio ntpd[1199]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Dec 16 12:28:14 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.123 Dec 16 12:28:14 volumio ntpd[1199]: DNS: Pool skipping: 170.210.222.10 Dec 16 12:28:14 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.1 Dec 16 12:28:14 volumio ntpd[1199]: DNS: Pool skipping: 168.96.251.195 Dec 16 12:28:14 volumio ntpd[1199]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Dec 16 12:28:15 volumio ntpd[1199]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Dec 16 12:28:15 volumio volumio[1559]: info: Loading plugin "upnp_browser"... Dec 16 12:28:15 volumio ntpd[1199]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Dec 16 12:28:15 volumio ntpd[1199]: DNS: Pool skipping: 168.96.251.195 Dec 16 12:28:15 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.123 Dec 16 12:28:15 volumio ntpd[1199]: DNS: Pool skipping: 170.210.222.10 Dec 16 12:28:15 volumio ntpd[1199]: DNS: Pool skipping: 162.159.200.1 Dec 16 12:28:15 volumio ntpd[1199]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Dec 16 12:28:16 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Dec 16 12:28:16 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:28:16 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:28:16 volumio upmpdcli[2146]: Could not open config: /tmp/upmpdcli.conf Dec 16 12:28:16 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:28:16 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 16 12:28:17 volumio volumio[1559]: info: Starting UPNP Browser Dec 16 12:28:17 volumio volumio[1559]: info: Loading plugin "alarm-clock"... Dec 16 12:28:17 volumio volumio[1559]: info: Loading plugin "airplay_emulation"... Dec 16 12:28:17 volumio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Dec 16 12:28:17 volumio volumio[1559]: info: Starting Shairport Sync Dec 16 12:28:17 volumio volumio[1559]: info: Loading plugin "last_100"... Dec 16 12:28:17 volumio volumio[1559]: info: Loading plugin "webradio"... Dec 16 12:28:17 volumio volumio[1559]: info: Loading plugin "i2s_dacs"... Dec 16 12:28:17 volumio volumio[1559]: info: I2S DAC not set, start Auto-detection Dec 16 12:28:17 volumio volumio[1559]: info: Loading plugin "volumiodiscovery"... Dec 16 12:28:17 volumio volumio[1559]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 16 12:28:17 volumio volumio[1559]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 12:28:17 volumio volumio[1559]: *** WARNING *** For more information see Dec 16 12:28:17 volumio volumio[1559]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 16 12:28:17 volumio volumio[1559]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 12:28:17 volumio volumio[1559]: *** WARNING *** For more information see Dec 16 12:28:17 volumio node[1559]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 16 12:28:17 volumio node[1559]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 12:28:17 volumio node[1559]: *** WARNING *** For more information see Dec 16 12:28:17 volumio node[1559]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 16 12:28:17 volumio node[1559]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 16 12:28:17 volumio node[1559]: *** WARNING *** For more information see Dec 16 12:28:17 volumio volumio[1559]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 16 12:28:17 volumio volumio[1559]: info: Discovery: Started advertising with name: Volumio Dec 16 12:28:17 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 16 12:28:17 volumio volumio[1559]: info: Loading plugin "spop"... Dec 16 12:28:18 volumio sudo[2082]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:24 volumio volumio-remote-updater[950]: [2025-12-16 12:28:24] [connect] Successful connection Dec 16 12:28:31 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Dec 16 12:28:31 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:28:31 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:28:31 volumio upmpdcli[2281]: Could not open config: /tmp/upmpdcli.conf Dec 16 12:28:31 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:28:31 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Dec 16 12:28:32 volumio volumio[1559]: info: Loading plugin "outputs"... Dec 16 12:28:32 volumio volumio[1559]: info: Loading plugin "albumart"... Dec 16 12:28:32 volumio volumio[1559]: info: Plugin example_plugin is not enabled Dec 16 12:28:32 volumio volumio[1559]: info: Loading plugin "inputs"... Dec 16 12:28:32 volumio volumio[2283]: Forking 3 albumart workers Dec 16 12:28:32 volumio volumio[2295]: Starting albumart workers Dec 16 12:28:32 volumio volumio[2293]: Starting albumart workers Dec 16 12:28:32 volumio volumio[2294]: Starting albumart workers Dec 16 12:28:32 volumio volumio[1559]: info: Loading plugin "updater_comm"... Dec 16 12:28:34 volumio volumio[1559]: info: Plugin mpdemulation is not enabled Dec 16 12:28:34 volumio volumio[1559]: info: Loading plugin "rest_api"... Dec 16 12:28:34 volumio volumio[1559]: info: Loading plugin "websocket"... Dec 16 12:28:34 volumio volumio[1559]: info: Starting Socket.io Server version 1.7.4 Dec 16 12:28:34 volumio volumio[1559]: info: Loading plugin "dmd2_music"... Dec 16 12:28:38 volumio volumio[1559]: info: Loading plugin "backup_restore"... Dec 16 12:28:38 volumio volumio[1559]: info: Applying required configuration parameters for plugin backup_restore Dec 16 12:28:38 volumio volumio[1559]: info: Loading plugin "mqtt_client"... Dec 16 12:28:39 volumio volumio-remote-updater[950]: [2025-12-16 12:28:39] [connect] Successful connection Dec 16 12:28:39 volumio volumio[1559]: info: Loading i18n strings for locale es Dec 16 12:28:39 volumio volumio[1559]: Updating browse sources language Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::initPlayerControls Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: Express server listening on port 3000 Dec 16 12:28:39 volumio volumio[1559]: [Metrics] WebUI: 31s 764.28ms Dec 16 12:28:39 volumio volumio[1559]: info: Setting Device type: x86 Dec 16 12:28:39 volumio volumio[1559]: info: CoreStateMachine::resetVolumioState Dec 16 12:28:39 volumio volumio[1559]: info: CoreStateMachine::getcurrentVolume Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::volumioRetrievevolume Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:39 volumio sudo[2386]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 16 12:28:39 volumio volumio[1559]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 16 12:28:39 volumio volumio[1559]: info: Completed loading Core Plugins Dec 16 12:28:39 volumio volumio[1559]: info: Preparing to generate the ALSA configuration file Dec 16 12:28:39 volumio sudo[2386]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:39 volumio sudo[2388]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 16 12:28:39 volumio sudo[2388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:39 volumio sudo[2386]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:39 volumio sudo[2388]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:39 volumio volumio[1559]: info: Volumio Network Manager: Network status updated: 3 Dec 16 12:28:39 volumio volumio[1559]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 16 12:28:39 volumio volumio[1559]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.28.1 Engine version: 3 Transport: polling Total Clients: 1 Dec 16 12:28:39 volumio volumio[1559]: info: VolumeController:: Volume=47 Mute =false Dec 16 12:28:39 volumio volumio[1559]: info: CoreStateMachine::pushState Dec 16 12:28:39 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::volumioPushState Dec 16 12:28:39 volumio volumio[1559]: info: CoreStateMachine::updateTrackBlock Dec 16 12:28:39 volumio volumio[1559]: info: CorePlayQueue::getTrackBlock Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::volumioRetrievevolume Dec 16 12:28:39 volumio volumio[1559]: info: Asound.conf file unchanged, so no further update is needed Dec 16 12:28:39 volumio volumio[1559]: info: Output device has changed, restarting MPD Dec 16 12:28:39 volumio volumio[1559]: info: Output device has changed, restarting Shairport Sync Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:39 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:39 volumio sudo[2402]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 16 12:28:39 volumio sudo[2402]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:39 volumio sudo[2404]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 16 12:28:39 volumio sudo[2404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:39 volumio sudo[2402]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:39 volumio volumio[1559]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 12:28:39 volumio volumio[1559]: info: ___________ START PLUGINS ___________ Dec 16 12:28:39 volumio volumio[1559]: info: ControllerMpd::onStart: Initializing MPD Dec 16 12:28:39 volumio volumio[1559]: info: Creating MPD Configuration file Dec 16 12:28:39 volumio sudo[2412]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 16 12:28:39 volumio sudo[2412]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 12:28:40 volumio volumio[1559]: info: [1765898920001] CoreMusicLibrary::Adding element Media Servers Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 12:28:40 volumio volumio[1559]: info: UPNP Browser: Client initialized successfully Dec 16 12:28:40 volumio sudo[2412]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio sudo[2416]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:40 volumio sudo[2416]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:40 volumio volumio[1559]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 12:28:40 volumio volumio[1559]: info: [1765898920016] CoreMusicLibrary::Adding element Last_100 Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 16 12:28:40 volumio volumio[1559]: info: [1765898920017] CoreMusicLibrary::Adding element Webradio Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 12:28:40 volumio volumio[1559]: info: Initializing BBC Radios Dec 16 12:28:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 16 12:28:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 16 12:28:40 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 16 12:28:40 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 16 12:28:40 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 16 12:28:40 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 16 12:28:40 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 16 12:28:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 16 12:28:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:40 volumio sudo[2436]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 16 12:28:40 volumio sudo[2436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 16 12:28:40 volumio sudo[2442]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 16 12:28:40 volumio sudo[2436]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:40 volumio volumio[1559]: info: Creating Spotify config file Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: Stopping AccessToken refresher cron for DMD2 Music Dec 16 12:28:40 volumio volumio[1559]: info: AccessToken refresher cron started for DMD2 Music Dec 16 12:28:40 volumio volumio[1559]: info: [MQTT] Starting MQTT Client plugin Dec 16 12:28:40 volumio volumio[1559]: info: [MQTT] Device ID: volumio Dec 16 12:28:40 volumio volumio[1559]: info: [MQTT] Base topic: volumio Dec 16 12:28:40 volumio volumio[1559]: info: [MQTT] MQTT client is disabled Dec 16 12:28:40 volumio volumio[1559]: info: Volumio Calling Home Dec 16 12:28:40 volumio volumio[1559]: info: MPD Permissions set Dec 16 12:28:40 volumio volumio[1559]: info: MPD Permissions set Dec 16 12:28:40 volumio volumio[1559]: info: VolumeController:: Volume=47 Mute =false Dec 16 12:28:40 volumio volumio[1559]: info: CoreStateMachine::pushState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioPushState Dec 16 12:28:40 volumio volumio[1559]: info: Reloading queue from file Dec 16 12:28:40 volumio volumio[1559]: info: CoreStateMachine::setRepeat null single undefined Dec 16 12:28:40 volumio volumio[1559]: info: CoreStateMachine::pushState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioPushState Dec 16 12:28:40 volumio volumio[1559]: info: CoreStateMachine::setRandom null Dec 16 12:28:40 volumio volumio[1559]: info: CoreStateMachine::pushState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioPushState Dec 16 12:28:40 volumio volumio[1559]: info: Spotify config file written Dec 16 12:28:40 volumio volumio[1559]: info: No need to fix Spotify hosts Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 16 12:28:40 volumio sudo[2454]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Dec 16 12:28:40 volumio sudo[2457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 16 12:28:40 volumio sudo[2457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:40 volumio sudo[2454]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:40 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:28:40 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:28:40 volumio systemd[1]: Started go-librespot-daemon.service - go-librespot Daemon. Dec 16 12:28:40 volumio sudo[2457]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:40 volumio go-librespot[2468]: go-librespot daemon starting... Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 16 12:28:40 volumio volumio[1559]: info: Discovery: adding a0b303f0-44ba-41b3-bd77-cdae25c677f4 Dec 16 12:28:40 volumio volumio[1559]: info: Discovery: Found device Volumio Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio volumio[1559]: info: Discovery: this is already registered, a0b303f0-44ba-41b3-bd77-cdae25c677f4 Dec 16 12:28:40 volumio volumio[1559]: info: Discovery: Found device Volumio Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio volumio[1559]: 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 Dec 16 12:28:40 volumio volumio-remote-updater[950]: [2025-12-16 12:28:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1765898919 101 Dec 16 12:28:40 volumio volumio[1559]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Dec 16 12:28:40 volumio volumio[1559]: info: Starting Shairport Sync Dec 16 12:28:40 volumio volumio[1559]: info: Starting Shairport Sync Dec 16 12:28:40 volumio volumio[1559]: info: Starting Shairport Sync Dec 16 12:28:40 volumio sudo[2481]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 12:28:40 volumio sudo[2481]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:40 volumio sudo[2485]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 12:28:40 volumio sudo[2483]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 16 12:28:40 volumio sudo[2485]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:40 volumio sudo[2483]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 16 12:28:40 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 16 12:28:40 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 12:28:40 volumio systemd[1]: shairport-sync.service: Consumed 1.745s CPU time. Dec 16 12:28:40 volumio volumio[1559]: info: Discovery: this is already registered, a0b303f0-44ba-41b3-bd77-cdae25c677f4 Dec 16 12:28:40 volumio volumio[1559]: info: Discovery: Found device Volumio Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:40 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:40 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 16 12:28:40 volumio sudo[2485]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:40 volumio sudo[2483]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:40 volumio sudo[2481]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:40 volumio volumio[1559]: info: Shairport-Sync Started Dec 16 12:28:40 volumio volumio[1559]: Error adding Membership: Error: addMembership EINVAL Dec 16 12:28:40 volumio volumio[1559]: info: Shairport-Sync Started Dec 16 12:28:40 volumio volumio[1559]: info: Shairport-Sync Started Dec 16 12:28:40 volumio volumio[1559]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 16 12:28:40 volumio volumio[1559]: SPOTIFY: BQDSxNwIvGuFBK7BEQgBevfT9BOqfPjGrpWf-huw0X4ODpVRD1mMdMVXkL4r0R1bRrbdLbr0XXAGN5LaL3WU0_fVlbghoxiNzVbzOQo5I6wqlmRw6eg3RIzuoze49EBL2CF8eJzDOUHzp5jteP-D7gzcHfHl28sQAbyGXrnYheIOBnsFqo0oSKUlACBw1lzlP9oJvAXJm07PVh48j03b96Fm338JI3Hy-86Q_wUkPFX2wbOr12MQ_YOR8ZlT1BXP0VsOrmMgj3UlcN_6Z1EswKZ2XRzsTvFKywOkcA Dec 16 12:28:40 volumio volumio[1559]: SPOTIFY: ------------------------------------------------------ ACCESS TOKEN ------------------------------------------------------ Dec 16 12:28:40 volumio volumio[1559]: info: New Spotify access token = BQDSxNwIvGuFBK7BEQgBevfT9BOqfPjGrpWf-huw0X4ODpVRD1mMdMVXkL4r0R1bRrbdLbr0XXAGN5LaL3WU0_fVlbghoxiNzVbzOQo5I6wqlmRw6eg3RIzuoze49EBL2CF8eJzDOUHzp5jteP-D7gzcHfHl28sQAbyGXrnYheIOBnsFqo0oSKUlACBw1lzlP9oJvAXJm07PVh48j03b96Fm338JI3Hy-86Q_wUkPFX2wbOr12MQ_YOR8ZlT1BXP0VsOrmMgj3UlcN_6Z1EswKZ2XRzsTvFKywOkcA Dec 16 12:28:40 volumio volumio[1559]: info: Spotify credentials grant success - running version from March 24, 2019 Dec 16 12:28:40 volumio volumio[1559]: info: Volumio called home Dec 16 12:28:43 volumio volumio[1559]: info: go-librespot daemon successfully initialized Dec 16 12:28:44 volumio volumio[1559]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Dec 16 12:28:45 volumio volumio[1559]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/139.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::volumioGetVisibleSources Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:45 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 16 12:28:45 volumio volumio[1559]: info: Received Get System Info Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:28:45 volumio volumio[1559]: info: Discovery: Getting this device information Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:45 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:45 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:45 volumio volumio[1559]: info: Listing playlists Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 16 12:28:45 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 12:28:45 volumio go-librespot[2469]: time="2025-12-16T12:28:45-03:00" level=info msg="running go-librespot 0.4.0" Dec 16 12:28:45 volumio go-librespot[2469]: time="2025-12-16T12:28:45-03:00" level=debug msg="app state loaded" Dec 16 12:28:45 volumio go-librespot[2469]: time="2025-12-16T12:28:45-03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 16 12:28:46 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:46 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:46 volumio volumio[1559]: info: Initializing connection to go-librespot Websocket Dec 16 12:28:46 volumio go-librespot[2469]: time="2025-12-16T12:28:46-03:00" level=debug msg="new websocket client" Dec 16 12:28:46 volumio volumio[1559]: info: Connection to go-librespot Websocket established Dec 16 12:28:47 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Dec 16 12:28:47 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 16 12:28:47 volumio volumio[1559]: info: Received Get System Info Dec 16 12:28:47 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:28:47 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:28:47 volumio volumio[1559]: info: Discovery: Getting this device information Dec 16 12:28:47 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:47 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:47 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:28:47 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Dec 16 12:28:47 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:28:47 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Dec 16 12:28:47 volumio sudo[2454]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:47 volumio volumio[1559]: info: Upmpdcli Daemon Started Dec 16 12:28:47 volumio mpd[2443]: 2025-12-16T12:28:47 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 16 12:28:47 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 16 12:28:47 volumio sudo[2416]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:47 volumio sudo[2404]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:47 volumio volumio[1559]: info: Completed starting Core Plugins Dec 16 12:28:47 volumio volumio[1559]: info: ------------------------------------------- Dec 16 12:28:47 volumio volumio[1559]: info: ----- MyVolumio plugins startup ---- Dec 16 12:28:47 volumio volumio[1559]: info: ------------------------------------------- Dec 16 12:28:47 volumio volumio[1559]: info: [MyVolumio PluginManager] Fetching plans data.... Dec 16 12:28:47 volumio volumio[1559]: info: MPD running with PID2443 Dec 16 12:28:47 volumio volumio[1559]: ,establishing connection Dec 16 12:28:47 volumio volumio[1559]: error: MPD error: The expression evaluated to a falsy value: Dec 16 12:28:47 volumio volumio[1559]: assert.ok(self.idling) Dec 16 12:28:47 volumio volumio[1559]: error: The expression evaluated to a falsy value: Dec 16 12:28:47 volumio volumio[1559]: assert.ok(self.idling) Dec 16 12:28:47 volumio volumio[1559]: error: MPD error: The expression evaluated to a falsy value: Dec 16 12:28:47 volumio volumio[1559]: assert.ok(self.idling) Dec 16 12:28:47 volumio volumio[1559]: error: The expression evaluated to a falsy value: Dec 16 12:28:47 volumio volumio[1559]: assert.ok(self.idling) Dec 16 12:28:47 volumio volumio[1559]: error: updateQueue error: null Dec 16 12:28:49 volumio volumio[1559]: info: Getting Spotify volume Dec 16 12:28:49 volumio volumio[1559]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Dec 16 12:28:49 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:49 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:49 volumio volumio[1559]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Dec 16 12:28:49 volumio volumio[1559]: SPOTIFY: SPOTIFY VOLUME undefined Dec 16 12:28:49 volumio volumio[1559]: SPOTIFY: VOLUMIO VOLUME 47 Dec 16 12:28:49 volumio volumio[1559]: info: Aligning Spotify Volume to Volumio Volume Dec 16 12:28:49 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:28:49 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:28:49 volumio volumio[1559]: info: Setting Spotify Volume from Volumio: 47 Dec 16 12:28:49 volumio upmpdcli[2559]: writing RSA key Dec 16 12:28:50 volumio sudo[2568]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 16 12:28:50 volumio sudo[2568]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:50 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 16 12:28:50 volumio sudo[2568]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:50 volumio volumio[1559]: info: Successfully started MPD Monitor Dec 16 12:28:50 volumio mpd_monitor.sh[2571]: MPD Monitor Service: Starting MPD Monitor Service Dec 16 12:28:50 volumio sudo[2573]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 16 12:28:50 volumio sudo[2573]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:50 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 16 12:28:50 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 16 12:28:50 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 16 12:28:50 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 16 12:28:50 volumio sudo[2573]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:50 volumio mpd_monitor.sh[2578]: MPD Monitor Service: Starting MPD Monitor Service Dec 16 12:28:50 volumio volumio[1559]: info: Successfully started MPD Monitor Dec 16 12:28:51 volumio volumio[1559]: SPOTIFY: SETTING SPOTIFY VOLUME 47 Dec 16 12:28:51 volumio volumio[1559]: info: Sending Spotify command with payload to local API: /player/volume Dec 16 12:28:52 volumio volumio[1559]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Dec 16 12:28:55 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Dec 16 12:28:56 volumio volumio[1559]: info: Adding plugin bluetooth to MyMusic Plugins Dec 16 12:28:56 volumio volumio[1559]: info: Adding plugin multiroom to MyMusic Plugins Dec 16 12:28:56 volumio volumio[1559]: info: Adding plugin metavolumio to MyMusic Plugins Dec 16 12:28:56 volumio volumio[1559]: info: Adding plugin cd_controller to MyMusic Plugins Dec 16 12:28:56 volumio volumio[1559]: info: Adding plugin qobuzconnect to MyMusic Plugins Dec 16 12:28:56 volumio volumio[1559]: info: Adding plugin smart_inputs to MyMusic Plugins Dec 16 12:28:56 volumio volumio[1559]: info: Adding plugin tidalconnect to MyMusic Plugins Dec 16 12:28:56 volumio volumio[1559]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Dec 16 12:28:57 volumio volumio[1559]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Dec 16 12:28:57 volumio volumio[1559]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Dec 16 12:28:57 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:57 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:28:57 volumio volumio[1559]: info: Starting MyVolumio Remote Streaming Endpoints Dec 16 12:28:57 volumio volumio[1559]: info: MyVolumio login type: Token Dec 16 12:28:57 volumio volumio[1559]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Dec 16 12:28:57 volumio volumio[1559]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Dec 16 12:28:57 volumio volumio[1559]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Dec 16 12:28:57 volumio volumio[1559]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Dec 16 12:28:57 volumio volumio[1559]: info: Streaming services startup Dec 16 12:28:57 volumio volumio[1559]: info: Starting Streaming Daemon Dec 16 12:28:57 volumio sudo[2606]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 16 12:28:57 volumio sudo[2606]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:28:57 volumio volumio[1559]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Dec 16 12:28:57 volumio sudo[2606]: pam_unix(sudo:session): session closed for user root Dec 16 12:28:57 volumio volumio[1559]: error: Cannot start Volumio Streaming Daemon Dec 16 12:28:57 volumio volumio[1559]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 16 12:28:57 volumio volumio[1559]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 16 12:28:57 volumio volumio[1559]: error: MyVolumio Custom Token format not valid, refreshing it Dec 16 12:28:59 volumio volumio[1559]: info: MyVolumio login type: Token Dec 16 12:28:59 volumio volumio[1559]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Dec 16 12:29:00 volumio volumio[1559]: info: MyVolumio token set successfully Dec 16 12:29:00 volumio volumio[1559]: info: MYVOLUMIO: Adding device Dec 16 12:29:00 volumio volumio[1559]: info: MYVOLUMIO: Evaluating Server Dec 16 12:29:00 volumio volumio[1559]: info: MyVolumio status changed Dec 16 12:29:00 volumio volumio[1559]: info: Streaming services startup Dec 16 12:29:00 volumio volumio[1559]: info: Starting Streaming Daemon Dec 16 12:29:00 volumio volumio[1559]: info: Removing browser output: myVolumio user plan is not superstar Dec 16 12:29:00 volumio volumio[1559]: info: Removing audio output: Dec 16 12:29:00 volumio volumio[1559]: info: Stoppping Tunnel 1 Dec 16 12:29:00 volumio sudo[2636]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 16 12:29:00 volumio sudo[2636]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:29:00 volumio sudo[2638]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Dec 16 12:29:00 volumio sudo[2638]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 16 12:29:00 volumio sudo[2636]: pam_unix(sudo:session): session closed for user root Dec 16 12:29:00 volumio volumio[1559]: error: Cannot start Volumio Streaming Daemon Dec 16 12:29:00 volumio volumio[1559]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 16 12:29:00 volumio volumio[1559]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 16 12:29:00 volumio sudo[2638]: pam_unix(sudo:session): session closed for user root Dec 16 12:29:00 volumio volumio[1559]: info: Remote SSH Stopped Dec 16 12:29:01 volumio volumio[1559]: info: Setting Geolocation for MyVolumio to us1 Dec 16 12:29:01 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:29:01 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:29:01 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:29:02 volumio volumio[1559]: info: Successfully Added MyVolumio device Dec 16 12:29:02 volumio volumio[1559]: info: Updating MyVolumio device info Dec 16 12:29:02 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:29:02 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:29:02 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:29:02 volumio volumio[1559]: info: Successfully Updated MyVolumio device Dec 16 12:29:04 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 12:29:04 volumio volumio[1559]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 16 12:29:04 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 16 12:29:04 volumio volumio[1559]: info: Received Get System Version Dec 16 12:29:04 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 12:29:04 volumio volumio[1559]: info: Received Get System Info Dec 16 12:29:04 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 16 12:29:04 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 16 12:29:04 volumio volumio[1559]: info: Discovery: Getting this device information Dec 16 12:29:04 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:29:04 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:29:04 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 16 12:29:10 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 16 12:29:10 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 16 12:29:10 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 16 12:29:10 volumio volumio-remote-updater[950]: Test mode enabled Dec 16 12:29:10 volumio volumio-remote-updater[950]: Alpha mode disabled Dec 16 12:29:10 volumio volumio-remote-updater[950]: Alpha legacy test mode disabled Dec 16 12:29:10 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Dec 16 12:29:11 volumio volumio[1559]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 16 12:29:11 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 16 12:29:12 volumio volumio[1559]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 16 12:29:12 volumio volumio[1559]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 16 12:29:12 volumio volumio[1559]: info: CoreCommandRouter::volumioGetState Dec 16 12:29:12 volumio volumio[1559]: info: CorePlayQueue::getTrack 0 Dec 16 12:29:16 volumio go-librespot[2469]: time="2025-12-16T12:29:16-03:00" level=fatal msg="failed running with username and spotify token" error="failed getting endpoints from resolver: failed fetching apresolve URL: Get \"https://apresolve.spotify.com/?type=accesspoint&type=dealer&type=spclient\": context deadline exceeded (Client.Timeout exceeded while awaiting headers)" Dec 16 12:29:16 volumio systemd[1]: go-librespot-daemon.service: Main process exited, code=exited, status=1/FAILURE Dec 16 12:29:16 volumio systemd[1]: go-librespot-daemon.service: Failed with result 'exit-code'. Dec 16 12:29:16 volumio volumio[1559]: error: Failed to send command to Spotify local API: /player/volume: Error: socket hang up Dec 16 12:29:16 volumio volumio[1559]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 12:29:16 volumio volumio[1559]: Error: socket hang up Dec 16 12:29:16 volumio volumio[1559]: at connResetException (node:internal/errors:720:14) Dec 16 12:29:16 volumio volumio[1559]: at Socket.socketOnEnd (node:_http_client:519:23) Dec 16 12:29:16 volumio volumio[1559]: at Socket.emit (node:events:526:35) Dec 16 12:29:16 volumio volumio[1559]: at endReadableNT (node:internal/streams/readable:1376:12) Dec 16 12:29:16 volumio volumio[1559]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { Dec 16 12:29:16 volumio volumio[1559]: code: 'ECONNRESET', Dec 16 12:29:16 volumio volumio[1559]: response: undefined Dec 16 12:29:16 volumio volumio[1559]: } Dec 16 12:29:16 volumio volumio[1559]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 16 12:29:16 volumio sudo[2708]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-16 12:28' Dec 16 12:29:16 volumio sudo[2708]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="140c1549b54b48087be58e6d122fe2155a57ac20" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 11 17:45:53 UTC 2025" VOLUMIO_VERSION="4.080" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="b38aafa3726bf7413e6b752a9a6a9faa"