Feb 23 22:43:03 studio volumio-remote-updater[910]: [2026-02-23 22:43:03] [info] asio async_connect error: asio.system:111 (Connection refused) Feb 23 22:43:03 studio volumio-remote-updater[910]: [2026-02-23 22:43:03] [info] Error getting remote endpoint: asio.system:107 (Transport endpoint is not connected) Feb 23 22:43:03 studio volumio-remote-updater[910]: [2026-02-23 22:43:03] [error] handle_connect error: Connection refused Feb 23 22:43:05 studio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 1. Feb 23 22:43:05 studio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 22:43:05 studio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 22:43:05 studio upmpdcli[1438]: Could not open config: /tmp/upmpdcli.conf Feb 23 22:43:05 studio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 22:43:05 studio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 22:43:05 studio wpa_supplicant[1361]: wlan0: Trying to associate with b0:95:75:71:94:29 (SSID='BTVOYAGER2100-5E_EXT' freq=2457 MHz) Feb 23 22:43:05 studio wpa_supplicant[1361]: ioctl[SIOCSIWESSID]: Operation now in progress Feb 23 22:43:05 studio wpa_supplicant[1361]: wlan0: Association request to the driver failed Feb 23 22:43:05 studio wireless.js[913]: WIRELESS.JS - INFO: WpaStateMachine: State transition: SCANNING -> ASSOCIATING (duration: 8552ms) Feb 23 22:43:06 studio wpa_supplicant[1361]: wlan0: Associated with b0:95:75:71:94:29 Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: WpaStateMachine: State transition: ASSOCIATING -> ASSOCIATED (duration: 503ms) Feb 23 22:43:06 studio wpa_supplicant[1361]: wlan0: WPA: Key negotiation completed with b0:95:75:71:94:29 [PTK=CCMP GTK=CCMP] Feb 23 22:43:06 studio wpa_supplicant[1361]: wlan0: CTRL-EVENT-CONNECTED - Connection to b0:95:75:71:94:29 completed [id=0 id_str=] Feb 23 22:43:06 studio dhcpcd[956]: wlan0: carrier acquired Feb 23 22:43:06 studio dhcpcd[956]: wlan0: IAID 2f:33:e9:4b Feb 23 22:43:06 studio dhcpcd[956]: wlan0: adding address fe80::791a:b6ff:817d:3d1e Feb 23 22:43:06 studio dhcpcd[956]: ipv6_addaddr1: Permission denied Feb 23 22:43:06 studio dhcpcd[956]: wlan0: soliciting an IPv6 router Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: WpaStateMachine: State transition: ASSOCIATED -> COMPLETED (duration: 503ms) Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: WpaStateMachine: COMPLETED - connection successful Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: STAGE 2: Connection successful - Connected to b0:95:75:71:94:29 Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: USB WiFi Capabilities: Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: Chipset: 3-1:1.0 Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: AP mode: No Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: Concurrent: No Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: TOAST: USB adapter does not support hotspot mode Feb 23 22:43:06 studio wireless.js[913]: WIRELESS.JS - INFO: Restarting dhcpcd.service for reliable DHCP Feb 23 22:43:06 studio sudo[1467]: root : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart dhcpcd.service Feb 23 22:43:06 studio sudo[1467]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:06 studio systemd[1]: Stopping dhcpcd.service - DHCP Client Daemon on all interfaces... Feb 23 22:43:06 studio dhcpcd[1469]: sending signal TERM to pid 953 Feb 23 22:43:06 studio dhcpcd[1469]: sending signal TERM to pid 953 Feb 23 22:43:06 studio dhcpcd[1469]: waiting for pid 953 to exit Feb 23 22:43:06 studio dhcpcd[1469]: waiting for pid 953 to exit Feb 23 22:43:06 studio dhcpcd[956]: received SIGTERM, stopping Feb 23 22:43:06 studio dhcpcd[956]: wlan0: removing interface Feb 23 22:43:06 studio dhcpcd[956]: eth0: removing interface Feb 23 22:43:06 studio systemd[1]: dhcpcd.service: Deactivated successfully. Feb 23 22:43:06 studio systemd[1]: Stopped dhcpcd.service - DHCP Client Daemon on all interfaces. Feb 23 22:43:07 studio systemd[1]: Starting dhcpcd.service - DHCP Client Daemon on all interfaces... Feb 23 22:43:07 studio dhcpcd[1472]: dhcpcd-9.4.1 starting Feb 23 22:43:07 studio dhcpcd[1475]: dev: loaded udev Feb 23 22:43:07 studio dhcpcd[1475]: DUID 00:01:00:01:31:17:60:8f:d8:3a:dd:a6:e3:c5 Feb 23 22:43:07 studio dhcpcd[1472]: dhcp_vendor: No such process Feb 23 22:43:07 studio dhcpcd[1475]: dhcp_vendor: No such process Feb 23 22:43:07 studio systemd[1]: Started dhcpcd.service - DHCP Client Daemon on all interfaces. Feb 23 22:43:07 studio sudo[1467]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:07 studio dhcpcd[1475]: eth0: waiting for carrier Feb 23 22:43:07 studio dhcpcd[1475]: wlan0: IAID 2f:33:e9:4b Feb 23 22:43:07 studio dhcpcd[1475]: wlan0: adding address fe80::791a:b6ff:817d:3d1e Feb 23 22:43:07 studio dhcpcd[1475]: ipv6_addaddr1: Permission denied Feb 23 22:43:07 studio dhcpcd[1475]: wlan0: soliciting an IPv6 router Feb 23 22:43:08 studio dhcpcd[1475]: wlan0: soliciting a DHCP lease Feb 23 22:43:09 studio wireless.js[913]: WIRELESS.JS - INFO: Start ap Feb 23 22:43:09 studio iw[1491]: command failed: No such device (-19) Feb 23 22:43:09 studio wireless.js[913]: WIRELESS.JS - INFO: Notified systemd about wireless ready Feb 23 22:43:09 studio iwconfig[1492]: Error for wireless request "Set Power Management" (8B2C) : Feb 23 22:43:09 studio iwconfig[1492]: SET failed on device wlan0 ; Invalid argument. Feb 23 22:43:09 studio systemd[1]: Started wireless.service - Wireless Services. Feb 23 22:43:09 studio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 23 22:43:09 studio systemd[1]: Starting plymouth-quit.service - Terminate Plymouth Boot Screen... Feb 23 22:43:09 studio systemd[1]: Started volumio_cpu_tweak.service - Volumio Cpu Tweaker. Feb 23 22:43:09 studio volumio-cpu-tweak[1495]: Setting RT Priority for mpd Feb 23 22:43:09 studio volumio-cpu-tweak[1509]: pid 35's current scheduling policy: SCHED_OTHER Feb 23 22:43:09 studio volumio-cpu-tweak[1509]: pid 35's current scheduling priority: 0 Feb 23 22:43:09 studio volumio-cpu-tweak[1495]: Setting MPD Affinity Feb 23 22:43:09 studio volumio-cpu-tweak[1510]: pid 3's current affinity mask: f Feb 23 22:43:09 studio volumio-cpu-tweak[1495]: /bin/volumio_cpu_tweak: line 27: warning: command substitution: ignored null byte in input Feb 23 22:43:09 studio volumio-cpu-tweak[1495]: VOLUMIO CPU TWEAK: Setting CPU Governor: conservative Feb 23 22:43:09 studio systemd[1]: volumio_cpu_tweak.service: Deactivated successfully. Feb 23 22:43:09 studio systemd[1]: Received SIGRTMIN+21 from PID 395 (plymouthd). Feb 23 22:43:09 studio systemd[1]: Received SIGRTMIN+21 from PID 395 (plymouthd). Feb 23 22:43:09 studio systemd[1]: Finished plymouth-quit.service - Terminate Plymouth Boot Screen. Feb 23 22:43:09 studio systemd[1]: Finished plymouth-quit-wait.service - Hold until boot process finishes up. Feb 23 22:43:09 studio systemd[1]: Started serial-getty@ttyAMA10.service - Serial Getty on ttyAMA10. Feb 23 22:43:09 studio systemd[1]: Reached target getty.target - Login Prompts. Feb 23 22:43:09 studio volumio[1493]: info: ------------------------------------------- Feb 23 22:43:09 studio volumio[1493]: info: ----- Volumio3 ---- Feb 23 22:43:09 studio volumio[1493]: info: ------------------------------------------- Feb 23 22:43:09 studio volumio[1493]: info: ----- System startup ---- Feb 23 22:43:09 studio volumio[1493]: info: ------------------------------------------- Feb 23 22:43:09 studio volumio[1493]: info: MYVOLUMIO Environment detected Feb 23 22:43:10 studio volumio[1493]: info: Plugin folders cleanup Feb 23 22:43:10 studio volumio[1493]: info: Scanning into folder /volumio/app/plugins/ Feb 23 22:43:10 studio volumio[1493]: info: Scanning category audio_interface Feb 23 22:43:10 studio volumio[1493]: info: Scanning category miscellanea Feb 23 22:43:10 studio volumio[1493]: info: Scanning category music_service Feb 23 22:43:10 studio volumio[1493]: info: Scanning category plugins.json Feb 23 22:43:10 studio volumio[1493]: info: Scanning category system_controller Feb 23 22:43:10 studio volumio[1493]: info: Scanning category user_interface Feb 23 22:43:10 studio volumio[1493]: info: Scanning into folder /data/plugins/ Feb 23 22:43:10 studio volumio[1493]: info: Scanning category system_hardware Feb 23 22:43:10 studio volumio[1493]: info: Scanning category user_interface Feb 23 22:43:10 studio volumio[1493]: info: Plugin folders cleanup completed Feb 23 22:43:10 studio volumio[1493]: info: ------------------------------------------- Feb 23 22:43:10 studio volumio[1493]: info: ----- Core plugins startup ---- Feb 23 22:43:10 studio volumio[1493]: info: ------------------------------------------- Feb 23 22:43:10 studio volumio[1493]: info: Loading plugins from folder /volumio/app/plugins/ Feb 23 22:43:10 studio volumio[1493]: info: Adding plugin upnp to MyMusic Plugins Feb 23 22:43:10 studio volumio[1493]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 23 22:43:10 studio volumio[1493]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 23 22:43:10 studio volumio[1493]: info: Loading plugins from folder /data/plugins/ Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "system"... Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "appearance"... Feb 23 22:43:10 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:10 studio sudo[1536]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:10 studio sudo[1536]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:10 studio sudo[1536]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:10 studio sudo[1541]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:10 studio sudo[1541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:10 studio sudo[1541]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:10 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "network"... Feb 23 22:43:10 studio volumio[1493]: info: Refreshing Cached IP Addresses Feb 23 22:43:10 studio sudo[1544]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:43:10 studio sudo[1544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:10 studio sudo[1546]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:10 studio sudo[1546]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:10 studio sudo[1544]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "services"... Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "volumio5onboarding"... Feb 23 22:43:10 studio sudo[1546]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:10 studio sudo[1559]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 23 22:43:10 studio sudo[1559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "alsa_controller"... Feb 23 22:43:10 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "wizard"... Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "networkfs"... Feb 23 22:43:10 studio volumio[1493]: info: Starting Udev Watcher for removable devices Feb 23 22:43:10 studio volumio[1493]: info: Mounting Device Samsung_USB Feb 23 22:43:10 studio sudo[1580]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Samsung_USB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 23 22:43:10 studio sudo[1580]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:10 studio kernel: FAT-fs (sda1): utf8 is not a recommended IO charset for FAT filesystems, filesystem will be case sensitive! Feb 23 22:43:10 studio sudo[1580]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:10 studio volumio[1493]: info: Ignoring mount for partition: boot Feb 23 22:43:10 studio volumio[1493]: info: Ignoring mount for partition: volumio Feb 23 22:43:10 studio volumio[1493]: info: Ignoring mount for partition: volumio_data Feb 23 22:43:10 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "volumio_command_line_client"... Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "upnp"... Feb 23 22:43:10 studio volumio[1493]: info: [1771886590661] Starting Upmpd Daemon Feb 23 22:43:10 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "my_music"... Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "mpd"... Feb 23 22:43:10 studio volumio[1493]: info: Loading plugin "upnp_browser"... Feb 23 22:43:11 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:11 studio volumio[1493]: info: Starting UPNP Browser Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "alarm-clock"... Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "airplay_emulation"... Feb 23 22:43:11 studio volumio[1493]: info: Starting Shairport Sync Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "last_100"... Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "webradio"... Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "i2s_dacs"... Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "volumiodiscovery"... Feb 23 22:43:11 studio volumio[1493]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:11 studio volumio[1493]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:11 studio volumio[1493]: *** WARNING *** For more information see Feb 23 22:43:11 studio volumio[1493]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:11 studio volumio[1493]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:11 studio volumio[1493]: *** WARNING *** For more information see Feb 23 22:43:11 studio node[1493]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:11 studio node[1493]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:11 studio node[1493]: *** WARNING *** For more information see Feb 23 22:43:11 studio node[1493]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:11 studio node[1493]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:11 studio node[1493]: *** WARNING *** For more information see Feb 23 22:43:11 studio volumio[1493]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 23 22:43:11 studio volumio[1493]: info: Discovery: Started advertising with name: Studio Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "peppy_screensaver"... Feb 23 22:43:11 studio volumio[1493]: info: Applying required configuration parameters for plugin peppy_screensaver Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "outputs"... Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "albumart"... Feb 23 22:43:11 studio volumio[1493]: info: Plugin example_plugin is not enabled Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "inputs"... Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "updater_comm"... Feb 23 22:43:11 studio volumio[1493]: info: Plugin mpdemulation is not enabled Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "rest_api"... Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "websocket"... Feb 23 22:43:11 studio volumio[1493]: info: Starting Socket.io Server version 1.7.4 Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "rotaryencoder2"... Feb 23 22:43:11 studio volumio[1593]: Forking 3 albumart workers Feb 23 22:43:11 studio volumio[1493]: info: Loading plugin "touch_display"... Feb 23 22:43:11 studio volumio[1493]: info: Applying required configuration parameters for plugin touch_display Feb 23 22:43:11 studio volumio[1605]: Starting albumart workers Feb 23 22:43:11 studio volumio[1603]: Starting albumart workers Feb 23 22:43:11 studio volumio[1493]: info: Loading i18n strings for locale en Feb 23 22:43:11 studio volumio[1493]: Updating browse sources language Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:11 studio volumio[1604]: Starting albumart workers Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::initPlayerControls Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 22:43:11 studio volumio[1493]: Express server listening on port 3000 Feb 23 22:43:11 studio volumio[1493]: [Metrics] WebUI: 2s 320.61ms Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::resetVolumioState Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::getcurrentVolume Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 22:43:11 studio volumio[1493]: info: Volumio Network Manager: Network status updated: 0 Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::pushState Feb 23 22:43:11 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::updateTrackBlock Feb 23 22:43:11 studio volumio[1493]: info: CorePlayQueue::getTrackBlock Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 22:43:11 studio volumio[1493]: info: Reloading queue from file Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::setRepeat null single undefined Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::pushState Feb 23 22:43:11 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::setRandom null Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::pushState Feb 23 22:43:11 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:11 studio volumio[1493]: info: Setting Device type: Raspberry PI Feb 23 22:43:11 studio volumio[1493]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 23 22:43:11 studio volumio[1493]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Feb 23 22:43:11 studio volumio[1493]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 23 22:43:11 studio volumio[1493]: info: CoreStateMachine::pushState Feb 23 22:43:11 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:11 studio volumio[1493]: info: Completed loading Core Plugins Feb 23 22:43:11 studio volumio[1493]: info: Preparing to generate the ALSA configuration file Feb 23 22:43:11 studio volumio[1493]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 23 22:43:11 studio volumio[1493]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Feb 23 22:43:11 studio volumio[1493]: info: Reading ALSA contributions from plugins. Feb 23 22:43:11 studio volumio[1493]: info: Asound.conf file unchanged, so no further update is needed Feb 23 22:43:11 studio volumio[1493]: info: Output device has changed, restarting MPD Feb 23 22:43:11 studio volumio[1493]: info: Output device has changed, restarting Shairport Sync Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:11 studio volumio[1493]: info: ___________ START PLUGINS ___________ Feb 23 22:43:11 studio volumio[1493]: info: ControllerMpd::onStart: Initializing MPD Feb 23 22:43:11 studio volumio[1493]: info: Creating MPD Configuration file Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 22:43:11 studio volumio[1493]: info: [1771886591974] CoreMusicLibrary::Adding element Media Servers Feb 23 22:43:11 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:12 studio volumio[1493]: info: UPNP Browser: Client initialized successfully Feb 23 22:43:12 studio sudo[1675]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Feb 23 22:43:12 studio sudo[1559]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio sudo[1675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1690]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:12 studio sudo[1679]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 22:43:12 studio sudo[1690]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1665]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:12 studio sudo[1665]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1681]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:12 studio sudo[1679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1690]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio sudo[1663]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 22:43:12 studio sudo[1663]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio volumio[1493]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio sudo[1681]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1679]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio sudo[1663]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:12 studio volumio[1493]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 22:43:12 studio volumio[1493]: info: [1771886592158] CoreMusicLibrary::Adding element Last_100 Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 22:43:12 studio volumio[1493]: info: [1771886592159] CoreMusicLibrary::Adding element Webradio Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:12 studio sudo[1704]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:12 studio sudo[1704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:12 studio volumio[1493]: info: Initializing BBC Radios Feb 23 22:43:12 studio sudo[1704]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: Loading i18n strings for locale en Feb 23 22:43:12 studio sudo[1731]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:12 studio sudo[1731]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1731]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: /tmp/myfifo created Feb 23 22:43:12 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:12 studio volumio[1493]: info: /tmp/myfifosa created Feb 23 22:43:12 studio sudo[1734]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:12 studio sudo[1734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:12 studio sudo[1734]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 23 22:43:12 studio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 23 22:43:12 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:12 studio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 23 22:43:12 studio sudo[1675]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio sudo[1749]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Feb 23 22:43:12 studio sudo[1749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1749]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: snd-dummy loaded Feb 23 22:43:12 studio sudo[1745]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 22:43:12 studio sudo[1745]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:12 studio sudo[1754]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 23 22:43:12 studio sudo[1745]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:12 studio volumio[1493]: info: Adding peppy_screensaver REST Endpoint for plugin: user_interface/peppy_screensaver Feb 23 22:43:12 studio volumio[1493]: info: peppy_screensaver: REST endpoint registered: peppy_screensaver Feb 23 22:43:12 studio volumio[1493]: info: Adding peppy_screensaver_font REST Endpoint for plugin: user_interface/peppy_screensaver Feb 23 22:43:12 studio volumio[1493]: info: peppy_screensaver: REST endpoint registered: peppy_screensaver_font Feb 23 22:43:12 studio volumio[1493]: info: peppy_screensaver: Config version updated: 7d1221ce Feb 23 22:43:12 studio volumio[1493]: info: Loading i18n strings for locale en Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:12 studio volumio[1493]: info: Volumio Calling Home Feb 23 22:43:12 studio sudo[1795]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Feb 23 22:43:12 studio sudo[1795]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1795]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio sudo[1803]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Feb 23 22:43:12 studio sudo[1803]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1805]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Feb 23 22:43:12 studio sudo[1805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1800]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=24 pin_b=25 relative_axis=true steps-per-period=2 Feb 23 22:43:12 studio sudo[1800]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1807]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 23 22:43:12 studio sudo[1807]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio systemd[1]: Reloading. Feb 23 22:43:12 studio sudo[1800]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio kernel: rotary-encoder rotary@18: gray Feb 23 22:43:12 studio kernel: input: rotary@18 as /devices/platform/rotary@18/input/input7 Feb 23 22:43:12 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:12.483Z level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 23 22:43:12 studio volumio[1493]: Unhandled rejection Error: No sockets available, cannot start. Feb 23 22:43:12 studio volumio[1493]: at SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Feb 23 22:43:12 studio volumio[1493]: at SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Feb 23 22:43:12 studio volumio[1493]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Feb 23 22:43:12 studio volumio[1493]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Feb 23 22:43:12 studio volumio[1493]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Feb 23 22:43:12 studio volumio[1493]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Feb 23 22:43:12 studio volumio[1493]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Feb 23 22:43:12 studio volumio[1493]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Feb 23 22:43:12 studio volumio[1493]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:156:14) Feb 23 22:43:12 studio volumio[1493]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:398:24) Feb 23 22:43:12 studio volumio[1493]: at HashMap. (/volumio/app/pluginmanager.js:496:31) Feb 23 22:43:12 studio volumio[1493]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Feb 23 22:43:12 studio volumio[1493]: at proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Feb 23 22:43:12 studio volumio[1493]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:495:20) Feb 23 22:43:12 studio volumio[1493]: at Promise._successFn (/volumio/app/pluginmanager.js:142:29) Feb 23 22:43:12 studio volumio[1493]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 23 22:43:12 studio volumio[1493]: info: touch_display: No backlight interface detected. Feb 23 22:43:12 studio volumio[1493]: info: MPD Permissions set Feb 23 22:43:12 studio volumio[1493]: info: MPD Permissions set Feb 23 22:43:12 studio sudo[1838]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Feb 23 22:43:12 studio sudo[1838]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio volumio[1493]: 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 Feb 23 22:43:12 studio volumio[1493]: info: Discovery: adding 9e76ea4d-af0f-475f-ac76-eddeefb22767 Feb 23 22:43:12 studio volumio[1493]: info: Discovery: Found device Studio Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:12 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:12 studio sudo[1838]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: 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 Feb 23 22:43:12 studio volumio[1493]: info: Received Get System Info Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:12 studio volumio[1493]: info: Discovery: Getting this device information Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:12 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:12 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:12.619Z level=INFO msg="system info for 7805e7534090a9fbfd3fb6aa972f7c8a" deviceName=Studio deviceVariant=volumio deviceModel= softwareVersion=4.096 Feb 23 22:43:12 studio volumio[1493]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: Received Get System Info Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:12 studio volumio[1493]: info: Discovery: Getting this device information Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:12 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:12 studio volumio[1493]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 23 22:43:12 studio volumio[1493]: info: touch_display: IframeKeyboardBridge extension installed successfully Feb 23 22:43:12 studio volumio[1493]: info: peppy_screensaver: ALSA template: /data/plugins/user_interface/peppy_screensaver/Peppyalsa.postPeppyalsa.5.conf.tmpl (isX64=false) Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 22:43:12 studio volumio[1493]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 23 22:43:12 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:12.687Z level=INFO msg="enabling local network discovery" Feb 23 22:43:12 studio volumio[1493]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Feb 23 22:43:12 studio sudo[1865]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Feb 23 22:43:12 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:12.696Z level=INFO msg="enabling BLE discovery" Feb 23 22:43:12 studio sudo[1865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio volumio[1493]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 23 22:43:12 studio sudo[1869]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Feb 23 22:43:12 studio sudo[1869]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1865]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio sudo[1871]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Feb 23 22:43:12 studio sudo[1869]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio sudo[1871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1871]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: Starting Shairport Sync Feb 23 22:43:12 studio volumio[1493]: info: Starting Shairport Sync Feb 23 22:43:12 studio volumio[1493]: info: Starting Shairport Sync Feb 23 22:43:12 studio sudo[1876]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:12 studio sudo[1876]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1878]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:12 studio volumio[1493]: info: Starting Shairport Sync Feb 23 22:43:12 studio sudo[1878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1881]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 23 22:43:12 studio volumio[1493]: info: Preparing to generate the ALSA configuration file Feb 23 22:43:12 studio sudo[1883]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:12 studio sudo[1883]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1881]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio volumio[1493]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 23 22:43:12 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:12.743Z level=INFO msg="bootstrapping state" hasInternet=false Feb 23 22:43:12 studio volumio[1493]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Feb 23 22:43:12 studio volumio[1493]: info: Reading ALSA contributions from plugins. Feb 23 22:43:12 studio volumio[1493]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Feb 23 22:43:12 studio sudo[1889]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 22:43:12 studio sudo[1889]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio volumio[1493]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Feb 23 22:43:12 studio sudo[1889]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: MPD Permissions set Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: Asound.conf file unchanged, so no further update is needed Feb 23 22:43:12 studio volumio[1493]: info: Output device has changed, restarting MPD Feb 23 22:43:12 studio volumio[1493]: info: Output device has changed, restarting Shairport Sync Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio sudo[1901]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:12 studio sudo[1901]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1900]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 22:43:12 studio sudo[1900]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1900]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:12 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:12 studio volumio[1493]: info: MPD Permissions set Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:12 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:12 studio volumio[1493]: info: peppy_screensaver: pushState - status=stop service=mpd volatile=false Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:12 studio sudo[1807]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:12 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:12 studio volumio[1493]: info: touch_display: systemctl daemon-reload succeeded. Feb 23 22:43:12 studio sudo[1803]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:12 studio volumio[1493]: info: Starting Shairport Sync Feb 23 22:43:12 studio volumio[1493]: info: touch_display: systemctl stop getty@tty1.service succeeded. Feb 23 22:43:12 studio sudo[1914]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Feb 23 22:43:12 studio sudo[1914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio sudo[1916]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:12 studio sudo[1916]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:12 studio systemd[1]: Reloading. Feb 23 22:43:13 studio volumio-remote-updater[910]: [2026-02-23 22:43:13] [connect] Successful connection Feb 23 22:43:13 studio volumio-remote-updater[910]: [2026-02-23 22:43:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1771886593 101 Feb 23 22:43:13 studio volumio[1493]: 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: 6 Feb 23 22:43:13 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:13 studio sudo[1945]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:13 studio sudo[1945]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:13 studio sudo[1945]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio sudo[1950]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:13 studio sudo[1950]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:13 studio sudo[1950]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:13 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Feb 23 22:43:13 studio sudo[1953]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:13 studio sudo[1953]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:13 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Feb 23 22:43:13 studio sudo[1956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:13 studio sudo[1956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:13 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:13 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:13 studio sudo[1805]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio volumio[1493]: info: touch_display: systemctl disable getty@tty1.service succeeded. Feb 23 22:43:13 studio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 23 22:43:13 studio systemd[1]: Started volumio-kiosk.service - Volumio Kiosk. Feb 23 22:43:13 studio sudo[1914]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio volumio[1493]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Feb 23 22:43:13 studio volumio[1493]: info: touch_display: Volumio Kiosk started. Feb 23 22:43:13 studio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 23 22:43:13 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:13 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:13 studio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 23 22:43:13 studio systemd[1]: shairport-sync.service: Consumed 1.553s CPU time. Feb 23 22:43:13 studio systemd[1]: mpd.service: Deactivated successfully. Feb 23 22:43:13 studio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 23 22:43:13 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:13 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:13 studio systemd[1]: mpd.socket: Deactivated successfully. Feb 23 22:43:13 studio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 23 22:43:13 studio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 23 22:43:13 studio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 23 22:43:13 studio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 23 22:43:13 studio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 23 22:43:13 studio sudo[1878]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio sudo[1916]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio sudo[1881]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio sudo[1876]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio volumio[1493]: info: Shairport-Sync Started Feb 23 22:43:13 studio sudo[1883]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio volumio[1493]: Error adding Membership: Error: addMembership EINVAL Feb 23 22:43:13 studio volumio[1493]: info: Shairport-Sync Started Feb 23 22:43:13 studio volumio[1493]: info: Shairport-Sync Started Feb 23 22:43:13 studio volumio[1493]: info: Shairport-Sync Started Feb 23 22:43:13 studio volumio[1493]: info: Shairport-Sync Started Feb 23 22:43:13 studio volumio[1493]: info: touch_display: X display number found: Feb 23 22:43:13 studio sudo[1977]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 22:43:13 studio sudo[1977]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:13 studio sudo[2000]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Feb 23 22:43:13 studio sudo[1977]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio sudo[2002]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=23 active_low=1 gpio_pull=up keycode=20 Feb 23 22:43:13 studio sudo[2002]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:13 studio kernel: input: button@17 as /devices/platform/button@17/input/input8 Feb 23 22:43:13 studio sudo[2002]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:13 studio volumio[1493]: info: touch_display: X display number found: 0 Feb 23 22:43:13 studio startx[1993]: X.Org X Server 1.21.1.7 Feb 23 22:43:13 studio startx[1993]: X Protocol Version 11, Revision 0 Feb 23 22:43:13 studio startx[1993]: Current Operating System: Linux studio 6.12.47-v8+ #1904 SMP PREEMPT Mon Sep 15 13:10:52 BST 2025 aarch64 Feb 23 22:43:13 studio startx[1993]: Kernel command line: reboot=w coherent_pool=1M 8250.nr_uarts=1 pci=pcie_bus_safe cgroup_disable=memory numa_policy=interleave nvme.max_host_mem_size_mb=0 numa=fake=8 system_heap.max_order=0 iommu_dma_numa_policy=interleave smsc95xx.macaddr=D8:3A:DD:A6:E3:C5 vc_mem.mem_base=0x3fc00000 vc_mem.mem_size=0x40000000 splash plymouth.ignore-serial-consoles dwc_otg.fiq_enable=1 dwc_otg.fiq_fsm_enable=1 dwc_otg.fiq_fsm_mask=0xF dwc_otg.nak_holdoff=1 quiet console=ttyAMA10,115200 console=tty1 imgpart=UUID=7e9efb31-d81e-40e6-b369-17d6be2a2543 imgfile=/volumio_current.sqsh bootpart=UUID=41F4-3F60 datapart=UUID=d86abd49-9ab6-4e7d-8df3-6405c27b7066 uuidconfig=cmdline.txt rootwait bootdelay=7 logo.nologo vt.global_cursor_default=0 net.ifnames=0 snd_bcm2835.enable_hdmi=1 snd_bcm2835.enable_headphones=1 loglevel=0 nodebug use_kmsg=no cfg80211.ieee80211_regdom=GB plymouth=90 Feb 23 22:43:13 studio startx[1993]: xorg-server 2:21.1.7-3+rpt3+deb12u11 (https://www.debian.org/support) Feb 23 22:43:13 studio startx[1993]: Current version of pixman: 0.44.0 Feb 23 22:43:13 studio startx[1993]: Before reporting problems, check http://wiki.x.org Feb 23 22:43:13 studio startx[1993]: to make sure that you have the latest version. Feb 23 22:43:13 studio startx[1993]: Markers: (--) probed, (**) from config file, (==) default setting, Feb 23 22:43:13 studio startx[1993]: (++) from command line, (!!) notice, (II) informational, Feb 23 22:43:13 studio startx[1993]: (WW) warning, (EE) error, (NI) not implemented, (??) unknown. Feb 23 22:43:13 studio startx[1993]: (==) Log file: "/var/log/Xorg.0.log", Time: Mon Feb 23 22:43:13 2026 Feb 23 22:43:13 studio startx[1993]: (==) Using config directory: "/etc/X11/xorg.conf.d" Feb 23 22:43:13 studio startx[1993]: (==) Using system config directory "/usr/share/X11/xorg.conf.d" Feb 23 22:43:13 studio volumio[1493]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Feb 23 22:43:13 studio volumio[1493]: info: touch_display: X display number found: 0 Feb 23 22:43:14 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:14 studio sudo[2028]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:14 studio sudo[2028]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:14 studio sudo[2028]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio sudo[2031]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:14 studio sudo[2031]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:14 studio sudo[2031]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:14 studio mpd[2003]: 2026-02-23T22:43:14 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 22:43:14 studio systemd[1]: Started mpd.service - Music Player Daemon. Feb 23 22:43:14 studio sudo[1956]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio sudo[1681]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio sudo[1901]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio sudo[1665]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio sudo[1953]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio volumio[1493]: info: peppy_screensaver: MPD output 1 enabled Feb 23 22:43:14 studio volumio[1493]: error: MPD error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: info: MPD running with PID2003 Feb 23 22:43:14 studio volumio[1493]: ,establishing connection Feb 23 22:43:14 studio volumio[1493]: error: MPD error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: MPD error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: MPD error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: MPD error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: The expression evaluated to a falsy value: Feb 23 22:43:14 studio volumio[1493]: assert.ok(self.idling) Feb 23 22:43:14 studio volumio[1493]: error: updateQueue error: null Feb 23 22:43:14 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:14 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:14 studio volumio[1493]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 23 22:43:14 studio sudo[2061]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Feb 23 22:43:14 studio sudo[2061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:14 studio sudo[2061]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio sudo[2065]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Feb 23 22:43:14 studio sudo[2065]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:14 studio sudo[2065]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:14 studio volumio[1493]: info: Completed starting Core Plugins Feb 23 22:43:14 studio volumio[1493]: info: ------------------------------------------- Feb 23 22:43:14 studio volumio[1493]: info: ----- MyVolumio plugins startup ---- Feb 23 22:43:14 studio volumio[1493]: info: ------------------------------------------- Feb 23 22:43:14 studio volumio[1493]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 23 22:43:15 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:15 studio sudo[2123]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:15 studio sudo[2123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:15 studio sudo[2123]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:15 studio sudo[2128]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:15 studio sudo[2128]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:15 studio sudo[2128]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:15 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:15 studio volumio[1493]: info: peppy_screensaver: Startup - MPD output 1 enabled Feb 23 22:43:15 studio dhcpcd[1475]: wlan0: offered 192.168.0.236 from 192.168.0.1 Feb 23 22:43:15 studio dhcpcd[1475]: wlan0: probing address 192.168.0.236/24 Feb 23 22:43:16 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:16 studio sudo[2185]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:16 studio sudo[2185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:16 studio sudo[2185]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:16 studio sudo[2188]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:16 studio sudo[2188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:16 studio sudo[2188]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:16 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:17 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:17 studio sudo[2250]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:17 studio sudo[2250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:17 studio sudo[2250]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:17 studio sudo[2253]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:17 studio sudo[2253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:17 studio sudo[2253]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:17 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:18 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:18 studio sudo[2282]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:18 studio sudo[2282]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:18 studio sudo[2282]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:18 studio sudo[2285]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:18 studio sudo[2285]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:18 studio sudo[2285]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:18 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:18 studio volumio[1493]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 23 22:43:18 studio systemd[1]: systemd-fsckd.service: Deactivated successfully. Feb 23 22:43:18 studio volumio[1493]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 23 22:43:18 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:19 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 22:43:19 studio volumio[1493]: info: Received Get System Info Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:19 studio volumio[1493]: info: Discovery: Getting this device information Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:19 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:19 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:19 studio volumio[1493]: info: Listing playlists Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 22:43:19 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 22:43:19 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:19 studio sudo[2297]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:19 studio sudo[2297]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:19 studio sudo[2297]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:19 studio sudo[2300]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:19 studio sudo[2300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:19 studio sudo[2300]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:19 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:19 studio dhcpcd[874]: timed out Feb 23 22:43:19 studio sh[871]: timed out Feb 23 22:43:19 studio dhcpcd[874]: main: control_stop: No such file or directory Feb 23 22:43:19 studio sh[871]: main: control_stop: No such file or directory Feb 23 22:43:19 studio sh[833]: ifup: failed to bring up eth0 Feb 23 22:43:19 studio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Feb 23 22:43:19 studio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Feb 23 22:43:20 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:20 studio systemd[1]: systemd-hostnamed.service: Deactivated successfully. Feb 23 22:43:20 studio sudo[2315]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:20 studio sudo[2315]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:20 studio sudo[2315]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:20 studio sudo[2318]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:20 studio sudo[2318]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:20 studio sudo[2318]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:20 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is undefined, ipV6 is undefined Feb 23 22:43:20 studio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 2. Feb 23 22:43:20 studio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 22:43:20 studio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 22:43:20 studio upmpdcli[2335]: Could not open config: /tmp/upmpdcli.conf Feb 23 22:43:20 studio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Feb 23 22:43:20 studio systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Feb 23 22:43:20 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 22:43:20 studio sudo[2337]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:43:20 studio sudo[2337]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:20 studio sudo[2337]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:20 studio sudo[2339]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:20 studio sudo[2339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:20 studio sudo[2339]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:20 studio sudo[2343]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 23 22:43:20 studio sudo[2343]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:20 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:43:20 studio volumio[1493]: info: Received Get System Info Feb 23 22:43:20 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:20 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:20 studio volumio[1493]: info: Discovery: Getting this device information Feb 23 22:43:20 studio volumio[1493]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:20 studio volumio[1493]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:20 studio volumio[1493]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:20 studio dhcpcd[1475]: wlan0: leased 192.168.0.236 for 7200 seconds Feb 23 22:43:20 studio avahi-daemon[888]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.236. Feb 23 22:43:20 studio avahi-daemon[888]: New relevant interface wlan0.IPv4 for mDNS. Feb 23 22:43:20 studio avahi-daemon[888]: Registering new address record for 192.168.0.236 on wlan0.IPv4. Feb 23 22:43:21 studio dhcpcd[1475]: wlan0: adding route to 192.168.0.0/24 Feb 23 22:43:21 studio systemd[1]: welcome.service: Deactivated successfully. Feb 23 22:43:21 studio systemd[1]: Stopped welcome.service - Show a welcome message on console. Feb 23 22:43:21 studio systemd[1]: Stopping welcome.service - Show a welcome message on console... Feb 23 22:43:21 studio systemd[1]: Starting welcome.service - Show a welcome message on console... Feb 23 22:43:21 studio welcome[2355]: Resolved ip:[1] 192.168.0.236 Feb 23 22:43:21 studio dhcpcd[1475]: wlan0: adding default route via 192.168.0.1 Feb 23 22:43:21 studio systemd[1]: Finished welcome.service - Show a welcome message on console. Feb 23 22:43:21 studio systemd[1]: Reached target ip-changed@wlan0.target - IP Address changed on wlan0. Feb 23 22:43:21 studio systemd[1]: Started nmbd.service - Samba NMB Daemon. Feb 23 22:43:21 studio wireless.js[913]: WIRELESS.JS - INFO: trying... Feb 23 22:43:21 studio systemd[1]: Starting winbind.service - Samba Winbind Daemon... Feb 23 22:43:21 studio sudo[2388]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Feb 23 22:43:21 studio sudo[2388]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:21 studio sudo[2388]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:21 studio sudo[2391]: root : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:21 studio sudo[2391]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:21 studio sudo[2391]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:21 studio wireless.js[913]: WIRELESS.JS - INFO: ... wlan0 IPv4 is 192.168.0.236, ipV6 is undefined Feb 23 22:43:21 studio wireless.js[913]: WIRELESS.JS - INFO: Connected to SSID: BTVOYAGER2100-5E_EXT Feb 23 22:43:21 studio wireless.js[913]: WIRELESS.JS - INFO: It's done! AP Feb 23 22:43:21 studio wireless.js[913]: WIRELESS.JS - INFO: Restarting avahi-daemon... Feb 23 22:43:21 studio sudo[2397]: root : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart avahi-daemon Feb 23 22:43:21 studio sudo[2397]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:21 studio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 23 22:43:21 studio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 23 22:43:21 studio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 23 22:43:21 studio systemd[1]: shairport-sync.service: Consumed 1.512s CPU time. Feb 23 22:43:21 studio systemd[1]: Stopping avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Feb 23 22:43:21 studio avahi-daemon[888]: Got SIGTERM, quitting. Feb 23 22:43:21 studio avahi-daemon[888]: Leaving mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.236. Feb 23 22:43:21 studio avahi-daemon[888]: Leaving mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Feb 23 22:43:21 studio avahi-daemon[888]: avahi-daemon 0.8 exiting. Feb 23 22:43:21 studio systemd[1]: avahi-daemon.service: Deactivated successfully. Feb 23 22:43:21 studio systemd[1]: Stopped avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Feb 23 22:43:21 studio systemd[1]: Starting avahi-daemon.service - Avahi mDNS/DNS-SD Stack... Feb 23 22:43:21 studio avahi-daemon[2399]: Process 888 died: No such process; trying to remove PID file. (/run/avahi-daemon//pid) Feb 23 22:43:21 studio avahi-daemon[2399]: Found user 'avahi' (UID 103) and group 'avahi' (GID 109). Feb 23 22:43:21 studio avahi-daemon[2399]: Successfully dropped root privileges. Feb 23 22:43:21 studio avahi-daemon[2399]: avahi-daemon 0.8 starting up. Feb 23 22:43:21 studio systemd[1]: Started avahi-daemon.service - Avahi mDNS/DNS-SD Stack. Feb 23 22:43:21 studio systemd[1]: volumio.service: Main process exited, code=killed, status=11/SEGV Feb 23 22:43:21 studio avahi-daemon[2399]: Successfully called chroot(). Feb 23 22:43:21 studio avahi-daemon[2399]: Successfully dropped remaining capabilities. Feb 23 22:43:21 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:21.237Z level=ERROR msg="failed reading message" component=volumio/socket error="websocket: close 1006 (abnormal closure): unexpected EOF" Feb 23 22:43:21 studio volumio-remote-updater[910]: [2026-02-23 22:43:21] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Feb 23 22:43:21 studio volumio-remote-updater[910]: [2026-02-23 22:43:21] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Feb 23 22:43:21 studio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 23 22:43:21 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:21.240Z level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused" Feb 23 22:43:21 studio avahi-daemon[2399]: Loading service file /services/volumio.service. Feb 23 22:43:21 studio avahi-daemon[2399]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.0.236. Feb 23 22:43:21 studio avahi-daemon[2399]: New relevant interface wlan0.IPv4 for mDNS. Feb 23 22:43:21 studio avahi-daemon[2399]: Joining mDNS multicast group on interface lo.IPv4 with address 127.0.0.1. Feb 23 22:43:21 studio avahi-daemon[2399]: New relevant interface lo.IPv4 for mDNS. Feb 23 22:43:21 studio avahi-daemon[2399]: Network interface enumeration completed. Feb 23 22:43:21 studio avahi-daemon[2399]: Registering new address record for 192.168.0.236 on wlan0.IPv4. Feb 23 22:43:21 studio avahi-daemon[2399]: Registering new address record for 127.0.0.1 on lo.IPv4. Feb 23 22:43:21 studio sudo[2397]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:21 studio sudo[2343]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:21 studio systemd[1]: volumio.service: Failed with result 'signal'. Feb 23 22:43:21 studio systemd[1]: volumio.service: Consumed 7.401s CPU time. Feb 23 22:43:21 studio wireless.js[913]: WIRELESS.JS - INFO: Notified systemd about wireless ready Feb 23 22:43:21 studio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 23 22:43:21 studio winbindd[2392]: [2026/02/23 22:43:21.300739, 0] ../../source3/winbindd/winbindd.c:1440(main) Feb 23 22:43:21 studio winbindd[2392]: winbindd version 4.17.8-Raspbian started. Feb 23 22:43:21 studio winbindd[2392]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Feb 23 22:43:21 studio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 23 22:43:21 studio winbindd[2392]: [2026/02/23 22:43:21.306318, 0] ../../source3/winbindd/winbindd_cache.c:3116(initialize_winbindd_cache) Feb 23 22:43:21 studio winbindd[2392]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Feb 23 22:43:21 studio systemd[1]: Started winbind.service - Samba Winbind Daemon. Feb 23 22:43:21 studio systemd[1]: Starting smbd.service - Samba SMB Daemon... Feb 23 22:43:21 studio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Feb 23 22:43:21 studio systemd[1]: Started dynamicswap.service - dynamicswap service. Feb 23 22:43:21 studio systemd[1]: Stopped volumio.service - Volumio Backend Module. Feb 23 22:43:21 studio systemd[1]: volumio.service: Consumed 7.401s CPU time. Feb 23 22:43:21 studio systemd[1]: Started volumio.service - Volumio Backend Module. Feb 23 22:43:21 studio systemd[1]: dynamicswap.service: Deactivated successfully. Feb 23 22:43:21 studio smbd[2462]: [2026/02/23 22:43:21.532832, 0] ../../source3/smbd/server.c:1741(main) Feb 23 22:43:21 studio smbd[2462]: smbd version 4.17.8-Raspbian started. Feb 23 22:43:21 studio smbd[2462]: Copyright Andrew Tridgell and the Samba Team 1992-2022 Feb 23 22:43:21 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:21.746Z level=ERROR msg="failed to read from connection" component=conn/multi error="http: Server closed" Feb 23 22:43:21 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:21.746Z level=INFO msg="connection closed, stopping read loop" component=conn/multi net=ws+tcp addr=[::]:7331 Feb 23 22:43:21 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:21.746Z level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: use of closed network connection" Feb 23 22:43:21 studio volumio5-onboarding[1746]: time=2026-02-23T22:43:21.751Z level=INFO msg="connection closed, stopping read loop" component=conn/multi net=ble addr=D8:3A:DD:A6:E3:C7%00 Feb 23 22:43:21 studio volumio5-onboarding[1746]: failed to run app: failed to run mDNS advertiser: failed to connect to Avahi daemon: failure Feb 23 22:43:21 studio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 23 22:43:21 studio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 23 22:43:21 studio systemd[1]: Started smbd.service - Samba SMB Daemon. Feb 23 22:43:21 studio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Feb 23 22:43:21 studio systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 23 22:43:21 studio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 23 22:43:21 studio volumio5-onboarding[2487]: time=2026-02-23T22:43:21.941Z level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 23 22:43:22 studio volumio[2456]: info: ------------------------------------------- Feb 23 22:43:22 studio volumio[2456]: info: ----- Volumio3 ---- Feb 23 22:43:22 studio volumio[2456]: info: ------------------------------------------- Feb 23 22:43:22 studio volumio[2456]: info: ----- System startup ---- Feb 23 22:43:22 studio volumio[2456]: info: ------------------------------------------- Feb 23 22:43:22 studio avahi-daemon[2399]: Server startup complete. Host name is studio.local. Local service cookie is 598701806. Feb 23 22:43:22 studio volumio[2456]: info: MYVOLUMIO Environment detected Feb 23 22:43:22 studio volumio[2456]: info: Plugin folders cleanup Feb 23 22:43:22 studio volumio[2456]: info: Scanning into folder /volumio/app/plugins/ Feb 23 22:43:22 studio volumio[2456]: info: Scanning category audio_interface Feb 23 22:43:22 studio volumio[2456]: info: Scanning category miscellanea Feb 23 22:43:22 studio volumio[2456]: info: Scanning category music_service Feb 23 22:43:22 studio volumio[2456]: info: Scanning category plugins.json Feb 23 22:43:22 studio volumio[2456]: info: Scanning category system_controller Feb 23 22:43:22 studio volumio[2456]: info: Scanning category user_interface Feb 23 22:43:22 studio volumio[2456]: info: Scanning into folder /data/plugins/ Feb 23 22:43:22 studio volumio[2456]: info: Scanning category system_hardware Feb 23 22:43:22 studio volumio[2456]: info: Scanning category user_interface Feb 23 22:43:22 studio volumio[2456]: info: Plugin folders cleanup completed Feb 23 22:43:22 studio volumio[2456]: info: ------------------------------------------- Feb 23 22:43:22 studio volumio[2456]: info: ----- Core plugins startup ---- Feb 23 22:43:22 studio volumio[2456]: info: ------------------------------------------- Feb 23 22:43:22 studio volumio[2456]: info: Loading plugins from folder /volumio/app/plugins/ Feb 23 22:43:22 studio volumio[2456]: info: Adding plugin upnp to MyMusic Plugins Feb 23 22:43:22 studio volumio[2456]: info: Adding plugin airplay_emulation to MyMusic Plugins Feb 23 22:43:22 studio volumio[2456]: info: Adding plugin upnp_browser to MyMusic Plugins Feb 23 22:43:22 studio volumio[2456]: info: Loading plugins from folder /data/plugins/ Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "system"... Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "appearance"... Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "network"... Feb 23 22:43:22 studio volumio[2456]: info: Refreshing Cached IP Addresses Feb 23 22:43:22 studio sudo[2508]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:43:22 studio sudo[2508]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:22 studio sudo[2508]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "services"... Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "volumio5onboarding"... Feb 23 22:43:22 studio sudo[2510]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:22 studio sudo[2510]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:22 studio sudo[2518]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "alsa_controller"... Feb 23 22:43:22 studio sudo[2518]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:22 studio sudo[2510]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:22 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "wizard"... Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "networkfs"... Feb 23 22:43:22 studio volumio[2456]: info: Starting Udev Watcher for removable devices Feb 23 22:43:22 studio volumio[2456]: info: Mounting Device Samsung_USB Feb 23 22:43:22 studio sudo[2544]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Samsung_USB -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 23 22:43:22 studio sudo[2544]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:22 studio sudo[2544]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:22 studio volumio[2456]: mount: /media/Samsung_USB: /dev/sda1 already mounted on /media/Samsung_USB. Feb 23 22:43:22 studio volumio[2456]: dmesg(1) may have more information after failed mount system call. Feb 23 22:43:22 studio volumio[2456]: error: Failed to mount Samsung_USB: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/Samsung_USB" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Feb 23 22:43:22 studio volumio[2456]: mount: /media/Samsung_USB: /dev/sda1 already mounted on /media/Samsung_USB. Feb 23 22:43:22 studio volumio[2456]: dmesg(1) may have more information after failed mount system call. Feb 23 22:43:22 studio volumio[2456]: info: Ignoring mount for partition: boot Feb 23 22:43:22 studio volumio[2456]: info: Ignoring mount for partition: volumio Feb 23 22:43:22 studio volumio[2456]: info: Ignoring mount for partition: volumio_data Feb 23 22:43:22 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "volumio_command_line_client"... Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "upnp"... Feb 23 22:43:22 studio volumio[2456]: info: [1771886602611] Starting Upmpd Daemon Feb 23 22:43:22 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "my_music"... Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "mpd"... Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "upnp_browser"... Feb 23 22:43:22 studio sudo[2518]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:22 studio ntpd[1263]: IO: Listen normally on 3 wlan0 192.168.0.236:123 Feb 23 22:43:22 studio ntpd[1263]: IO: new interface(s) found: waking up resolver Feb 23 22:43:22 studio ntpd[1263]: DNS: dns_probe: 3.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 23 22:43:22 studio ntpd[1263]: DNS: dns_check: processing 3.debian.pool.ntp.org, 8, 101 Feb 23 22:43:22 studio ntpd[1263]: DNS: Pool taking: 131.111.8.63 Feb 23 22:43:22 studio ntpd[1263]: DNS: Pool taking: 139.162.255.65 Feb 23 22:43:22 studio ntpd[1263]: DNS: Pool taking: 82.16.107.176 Feb 23 22:43:22 studio ntpd[1263]: DNS: Pool taking: 178.79.158.157 Feb 23 22:43:22 studio ntpd[1263]: DNS: dns_take_status: 3.debian.pool.ntp.org=>good, 8 Feb 23 22:43:22 studio avahi-daemon[2399]: Service "Studio" (/services/volumio.service) successfully established. Feb 23 22:43:22 studio volumio[2456]: info: Starting UPNP Browser Feb 23 22:43:22 studio volumio[2456]: info: Loading plugin "alarm-clock"... Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "airplay_emulation"... Feb 23 22:43:23 studio volumio[2456]: info: Starting Shairport Sync Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "last_100"... Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "webradio"... Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "i2s_dacs"... Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "volumiodiscovery"... Feb 23 22:43:23 studio volumio[2456]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:23 studio volumio[2456]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:23 studio volumio[2456]: *** WARNING *** For more information see Feb 23 22:43:23 studio volumio[2456]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:23 studio volumio[2456]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:23 studio volumio[2456]: *** WARNING *** For more information see Feb 23 22:43:23 studio volumio[2456]: info: Applying required configuration parameters for plugin volumiodiscovery Feb 23 22:43:23 studio volumio[2456]: info: Discovery: Started advertising with name: Studio Feb 23 22:43:23 studio node[2456]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:23 studio node[2456]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:23 studio node[2456]: *** WARNING *** For more information see Feb 23 22:43:23 studio node[2456]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Feb 23 22:43:23 studio node[2456]: *** WARNING *** Please fix your application to use the native API of Avahi! Feb 23 22:43:23 studio node[2456]: *** WARNING *** For more information see Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "peppy_screensaver"... Feb 23 22:43:23 studio volumio[2456]: info: Applying required configuration parameters for plugin peppy_screensaver Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "outputs"... Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "albumart"... Feb 23 22:43:23 studio volumio[2456]: info: Plugin example_plugin is not enabled Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "inputs"... Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "updater_comm"... Feb 23 22:43:23 studio volumio[2456]: info: Plugin mpdemulation is not enabled Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "rest_api"... Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "websocket"... Feb 23 22:43:23 studio volumio[2456]: info: Starting Socket.io Server version 1.7.4 Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "rotaryencoder2"... Feb 23 22:43:23 studio volumio[2550]: Forking 3 albumart workers Feb 23 22:43:23 studio volumio[2456]: info: Loading plugin "touch_display"... Feb 23 22:43:23 studio volumio[2456]: info: Applying required configuration parameters for plugin touch_display Feb 23 22:43:23 studio volumio[2456]: info: Loading i18n strings for locale en Feb 23 22:43:23 studio volumio[2456]: Updating browse sources language Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::initPlayerControls Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 22:43:23 studio volumio[2456]: Express server listening on port 3000 Feb 23 22:43:23 studio volumio[2456]: [Metrics] WebUI: 1s 466.46ms Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::resetVolumioState Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::getcurrentVolume Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 22:43:23 studio volumio[2456]: info: Volumio Network Manager: Network status updated: 2 Feb 23 22:43:23 studio volumio[2456]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::pushState Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::updateTrackBlock Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrackBlock Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioRetrievevolume Feb 23 22:43:23 studio volumio[2456]: 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: 2 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: Reloading queue from file Feb 23 22:43:23 studio volumio[2456]: 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: 2 Feb 23 22:43:23 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:23 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:23 studio volumio5-onboarding[2487]: time=2026-02-23T22:43:23.474Z level=INFO msg="system info for 7805e7534090a9fbfd3fb6aa972f7c8a" deviceName=Studio deviceVariant=volumio deviceModel= softwareVersion=4.096 Feb 23 22:43:23 studio volumio[2456]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::pushState Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::setRepeat null single undefined Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::pushState Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::setRandom null Feb 23 22:43:23 studio volumio[2456]: info: CoreStateMachine::pushState Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioPushState Feb 23 22:43:23 studio volumio[2456]: info: Setting Device type: Raspberry PI Feb 23 22:43:23 studio volumio[2456]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Feb 23 22:43:23 studio volumio[2456]: info: USB Boot Capable - System SBC Revision found in cpuinfo: c04170 Feb 23 22:43:23 studio volumio[2456]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Feb 23 22:43:23 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:23 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:23 studio volumio[2456]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Feb 23 22:43:23 studio volumio[2456]: info: Completed loading Core Plugins Feb 23 22:43:23 studio volumio[2456]: info: Preparing to generate the ALSA configuration file Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 22:43:23 studio volumio[2456]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 23 22:43:23 studio volumio[2456]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Feb 23 22:43:23 studio volumio[2456]: info: Reading ALSA contributions from plugins. Feb 23 22:43:23 studio volumio5-onboarding[2487]: time=2026-02-23T22:43:23.547Z level=INFO msg="enabling local network discovery" Feb 23 22:43:23 studio volumio[2564]: Starting albumart workers Feb 23 22:43:23 studio volumio5-onboarding[2487]: time=2026-02-23T22:43:23.575Z level=INFO msg="bootstrapping state" hasInternet=true Feb 23 22:43:23 studio volumio[2563]: Starting albumart workers Feb 23 22:43:23 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:23 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:23 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:23 studio volumio[2565]: Starting albumart workers Feb 23 22:43:23 studio volumio[2456]: info: Asound.conf file unchanged, so no further update is needed Feb 23 22:43:23 studio volumio[2456]: info: Output device has changed, restarting MPD Feb 23 22:43:23 studio volumio[2456]: info: Output device has changed, restarting Shairport Sync Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:23 studio sudo[2622]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 22:43:23 studio sudo[2622]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio sudo[2624]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:23 studio sudo[2622]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:23 studio sudo[2624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio volumio[2456]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:23 studio volumio[2456]: info: ___________ START PLUGINS ___________ Feb 23 22:43:23 studio volumio[2456]: info: ControllerMpd::onStart: Initializing MPD Feb 23 22:43:23 studio volumio[2456]: info: Creating MPD Configuration file Feb 23 22:43:23 studio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 23 22:43:23 studio sudo[2632]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Feb 23 22:43:23 studio sudo[2632]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 22:43:23 studio volumio[2456]: info: [1771886603686] CoreMusicLibrary::Adding element Media Servers Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:23 studio sudo[2637]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:23 studio sudo[2637]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio sudo[2634]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 22:43:23 studio volumio[2456]: info: UPNP Browser: Client initialized successfully Feb 23 22:43:23 studio sudo[2634]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:23 studio sudo[2634]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:23 studio sudo[2632]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:23 studio ntpd[1263]: DNS: dns_probe: 2.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 23 22:43:23 studio volumio[2456]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 22:43:23 studio volumio[2456]: info: [1771886603746] CoreMusicLibrary::Adding element Last_100 Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Feb 23 22:43:23 studio volumio[2456]: info: [1771886603751] CoreMusicLibrary::Adding element Webradio Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:23 studio ntpd[1263]: DNS: dns_check: processing 2.debian.pool.ntp.org, 8, 101 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 217.154.37.71 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 85.199.214.102 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 88.80.187.85 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 85.121.48.64 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 2a01:7e00::f03c:94ff:fee7:c867 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 2a05:b400:c::123:61 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 2a00:1098:0:86:1000:67:0:1 Feb 23 22:43:23 studio ntpd[1263]: DNS: Pool taking: 2001:470:1f1c:298::4:123 Feb 23 22:43:23 studio ntpd[1263]: DNS: dns_take_status: 2.debian.pool.ntp.org=>good, 8 Feb 23 22:43:23 studio volumio[2456]: info: Initializing BBC Radios Feb 23 22:43:23 studio systemd[1]: mpd.service: Deactivated successfully. Feb 23 22:43:23 studio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 23 22:43:23 studio systemd[1]: mpd.socket: Deactivated successfully. Feb 23 22:43:23 studio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 23 22:43:23 studio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 23 22:43:23 studio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:23 studio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 23 22:43:23 studio volumio[2456]: info: Loading i18n strings for locale en Feb 23 22:43:23 studio volumio[2456]: info: /tmp/myfifo created Feb 23 22:43:23 studio volumio[2456]: info: /tmp/myfifosa created Feb 23 22:43:23 studio sudo[2693]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Feb 23 22:43:23 studio sudo[2693]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio sudo[2681]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 22:43:23 studio sudo[2681]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:23 studio sudo[2681]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:23 studio sudo[2693]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:23 studio volumio[2456]: info: snd-dummy loaded Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:23 studio volumio[2456]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:23 studio volumio[2456]: info: Adding peppy_screensaver REST Endpoint for plugin: user_interface/peppy_screensaver Feb 23 22:43:23 studio volumio[2456]: info: peppy_screensaver: REST endpoint registered: peppy_screensaver Feb 23 22:43:23 studio volumio[2456]: info: Adding peppy_screensaver_font REST Endpoint for plugin: user_interface/peppy_screensaver Feb 23 22:43:23 studio volumio[2456]: info: peppy_screensaver: REST endpoint registered: peppy_screensaver_font Feb 23 22:43:23 studio volumio[2456]: info: peppy_screensaver: Config version updated: 7d1221ce Feb 23 22:43:23 studio volumio[2456]: info: Loading i18n strings for locale en Feb 23 22:43:23 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:23 studio volumio[2456]: info: Volumio Calling Home Feb 23 22:43:23 studio sudo[2728]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/volumiokioskextensions/IframeKeyboardBridge Feb 23 22:43:23 studio sudo[2728]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio sudo[2728]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:23 studio sudo[2734]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=24 pin_b=25 relative_axis=true steps-per-period=2 Feb 23 22:43:23 studio sudo[2734]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio sudo[2736]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Feb 23 22:43:23 studio sudo[2736]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio sudo[2734]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:23 studio sudo[2743]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Feb 23 22:43:23 studio sudo[2746]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Feb 23 22:43:23 studio sudo[2746]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio sudo[2743]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:23 studio systemd[1]: Reloading. Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: touch_display: No backlight interface detected. Feb 23 22:43:24 studio volumio[2456]: info: peppy_screensaver: pushState - status=stop service=mpd volatile=false Feb 23 22:43:24 studio volumio[2456]: error: [ROTARYENCODER2] addOverlay: * Failed to apply overlay '2_rotary-encoder' (kernel) Feb 23 22:43:24 studio volumio[2456]: info: MPD Permissions set Feb 23 22:43:24 studio volumio[2456]: info: MPD Permissions set Feb 23 22:43:24 studio sudo[2767]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Feb 23 22:43:24 studio sudo[2767]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio volumio[2456]: info: Volumio called home Feb 23 22:43:24 studio sudo[2767]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Feb 23 22:43:24 studio volumio[2456]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Feb 23 22:43:24 studio volumio[2456]: info: Discovery: adding 9e76ea4d-af0f-475f-ac76-eddeefb22767 Feb 23 22:43:24 studio volumio[2456]: info: Discovery: Found device Studio Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio sudo[2770]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/cp -r /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/content.js /data/plugins/user_interface/touch_display/iframe_keyboard_bridge/manifest.json /data/volumiokioskextensions/IframeKeyboardBridge/ Feb 23 22:43:24 studio sudo[2770]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio sudo[2770]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio sudo[2775]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Feb 23 22:43:24 studio sudo[2775]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio sudo[2775]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: Discovery: this is already registered, 9e76ea4d-af0f-475f-ac76-eddeefb22767 Feb 23 22:43:24 studio volumio[2456]: info: Discovery: Found device Studio Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: touch_display: IframeKeyboardBridge extension installed successfully Feb 23 22:43:24 studio volumio[2456]: info: peppy_screensaver: ALSA template: /data/plugins/user_interface/peppy_screensaver/Peppyalsa.postPeppyalsa.5.conf.tmpl (isX64=false) Feb 23 22:43:24 studio volumio[2456]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Feb 23 22:43:24 studio volumio[2456]: info: Starting Shairport Sync Feb 23 22:43:24 studio sudo[2796]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Feb 23 22:43:24 studio volumio[2456]: info: Starting Shairport Sync Feb 23 22:43:24 studio sudo[2796]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio sudo[2796]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio sudo[2794]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Feb 23 22:43:24 studio volumio[2456]: info: Starting Shairport Sync Feb 23 22:43:24 studio sudo[2794]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio volumio[2456]: info: Starting Shairport Sync Feb 23 22:43:24 studio sudo[2794]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio sudo[2804]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:24 studio sudo[2804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio sudo[2801]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 23 22:43:24 studio volumio[2456]: info: Preparing to generate the ALSA configuration file Feb 23 22:43:24 studio sudo[2801]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio sudo[2806]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:24 studio sudo[2806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio volumio[2456]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Feb 23 22:43:24 studio volumio[2456]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/95-touch_display-plugin.conf set. Feb 23 22:43:24 studio volumio[2456]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 23 22:43:24 studio volumio[2456]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Feb 23 22:43:24 studio volumio[2456]: info: Reading ALSA contributions from plugins. Feb 23 22:43:24 studio sudo[2798]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:24 studio sudo[2798]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: Asound.conf file unchanged, so no further update is needed Feb 23 22:43:24 studio volumio[2456]: info: Output device has changed, restarting MPD Feb 23 22:43:24 studio volumio[2456]: info: Output device has changed, restarting Shairport Sync Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:24 studio sudo[2813]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 22:43:24 studio sudo[2813]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio sudo[2814]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:24 studio volumio[2456]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 22:43:24 studio sudo[2814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio sudo[2813]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: MPD Permissions set Feb 23 22:43:24 studio volumio[2456]: info: Starting Shairport Sync Feb 23 22:43:24 studio sudo[2827]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 22:43:24 studio sudo[2827]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio mpd[2696]: 2026-02-23T22:43:24 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 22:43:24 studio systemd[1]: Started mpd.service - Music Player Daemon. Feb 23 22:43:24 studio sudo[2746]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio sudo[2637]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: touch_display: systemctl daemon-reload succeeded. Feb 23 22:43:24 studio sudo[2624]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio sudo[2832]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Feb 23 22:43:24 studio sudo[2832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio sudo[2736]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio systemd[1]: Reloading. Feb 23 22:43:24 studio volumio[2456]: error: MPD error: The expression evaluated to a falsy value: Feb 23 22:43:24 studio volumio[2456]: assert.ok(self.idling) Feb 23 22:43:24 studio volumio[2456]: error: The expression evaluated to a falsy value: Feb 23 22:43:24 studio volumio[2456]: assert.ok(self.idling) Feb 23 22:43:24 studio volumio[2456]: info: MPD running with PID2696 Feb 23 22:43:24 studio volumio[2456]: ,establishing connection Feb 23 22:43:24 studio volumio[2456]: info: touch_display: systemctl stop getty@tty1.service succeeded. Feb 23 22:43:24 studio volumio[2456]: error: updateQueue error: null Feb 23 22:43:24 studio volumio[2456]: error: updateQueue error: null Feb 23 22:43:24 studio ntpd[1263]: DNS: dns_probe: 1.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 23 22:43:24 studio ntpd[1263]: DNS: dns_check: processing 1.debian.pool.ntp.org, 8, 101 Feb 23 22:43:24 studio ntpd[1263]: DNS: Pool taking: 81.187.90.2 Feb 23 22:43:24 studio ntpd[1263]: DNS: Pool taking: 213.5.132.231 Feb 23 22:43:24 studio ntpd[1263]: DNS: Pool taking: 185.57.191.229 Feb 23 22:43:24 studio ntpd[1263]: DNS: Pool taking: 88.80.189.24 Feb 23 22:43:24 studio ntpd[1263]: DNS: dns_take_status: 1.debian.pool.ntp.org=>good, 8 Feb 23 22:43:24 studio volumio[2456]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS x86_64 14541.0.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/144.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Feb 23 22:43:24 studio sudo[2743]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: touch_display: systemctl disable getty@tty1.service succeeded. Feb 23 22:43:24 studio sudo[2856]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 22:43:24 studio sudo[2856]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:24 studio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 23 22:43:24 studio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 23 22:43:24 studio sudo[2832]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:24 studio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 23 22:43:24 studio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 23 22:43:24 studio systemd[1]: shairport-sync.service: Consumed 1.394s CPU time. Feb 23 22:43:24 studio volumio[2456]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Feb 23 22:43:24 studio volumio[2456]: info: touch_display: Volumio Kiosk started. Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: Completed starting Core Plugins Feb 23 22:43:24 studio volumio[2456]: info: ------------------------------------------- Feb 23 22:43:24 studio volumio[2456]: info: ----- MyVolumio plugins startup ---- Feb 23 22:43:24 studio volumio[2456]: info: ------------------------------------------- Feb 23 22:43:24 studio volumio[2456]: info: [MyVolumio PluginManager] Fetching plans data.... Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 23 22:43:24 studio sudo[2798]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio systemd[1]: mpd.service: Deactivated successfully. Feb 23 22:43:24 studio sudo[2806]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 23 22:43:24 studio sudo[2804]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: Shairport-Sync Started Feb 23 22:43:24 studio sudo[2801]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: Error adding Membership: Error: addMembership EINVAL Feb 23 22:43:24 studio volumio[2456]: info: Shairport-Sync Started Feb 23 22:43:24 studio sudo[2827]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: Shairport-Sync Started Feb 23 22:43:24 studio volumio[2456]: info: Shairport-Sync Started Feb 23 22:43:24 studio volumio[2456]: info: Shairport-Sync Started Feb 23 22:43:24 studio systemd[1]: mpd.socket: Deactivated successfully. Feb 23 22:43:24 studio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 23 22:43:24 studio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 23 22:43:24 studio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 23 22:43:24 studio volumio[2456]: info: touch_display: X display number found: 0 Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:43:24 studio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 22:43:24 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:24 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:24 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:24 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:24 studio volumio[2456]: info: Listing playlists Feb 23 22:43:24 studio sudo[2876]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 22:43:24 studio sudo[2876]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 23 22:43:24 studio sudo[2876]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:24 studio volumio[2456]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Feb 23 22:43:24 studio volumio[2456]: info: touch_display: X display number found: 0 Feb 23 22:43:25 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:25 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:25 studio volumio[2456]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 23 22:43:25 studio mpd[2878]: 2026-02-23T22:43:25 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 22:43:25 studio systemd[1]: Started mpd.service - Music Player Daemon. Feb 23 22:43:25 studio sudo[2856]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:25 studio sudo[2814]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:25 studio volumio[2456]: error: updateQueue error: null Feb 23 22:43:25 studio volumio[2456]: error: updateQueue error: null Feb 23 22:43:25 studio ntpd[1263]: DNS: dns_probe: 0.debian.pool.ntp.org, cast_flags:8, flags:101 Feb 23 22:43:25 studio ntpd[1263]: DNS: dns_check: processing 0.debian.pool.ntp.org, 8, 101 Feb 23 22:43:25 studio ntpd[1263]: DNS: Pool taking: 193.150.34.2 Feb 23 22:43:25 studio ntpd[1263]: DNS: Pool taking: 178.79.184.152 Feb 23 22:43:25 studio ntpd[1263]: DNS: Pool taking: 145.40.176.243 Feb 23 22:43:25 studio ntpd[1263]: DNS: Pool taking: 162.159.200.123 Feb 23 22:43:25 studio ntpd[1263]: DNS: dns_take_status: 0.debian.pool.ntp.org=>good, 8 Feb 23 22:43:25 studio volumio[2456]: info: peppy_screensaver: MPD output 1 enabled Feb 23 22:43:26 studio volumio-remote-updater[910]: [2026-02-23 22:43:26] [connect] Successful connection Feb 23 22:43:26 studio volumio-remote-updater[910]: [2026-02-23 22:43:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1771886606 101 Feb 23 22:43:26 studio volumio[2456]: 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: 8 Feb 23 22:43:26 studio volumio[2456]: info: peppy_screensaver: Startup - MPD output 1 enabled Feb 23 22:43:30 studio ntpd[1263]: CLOCK: time stepped by 1.298310 Feb 23 22:43:30 studio ntpd[1263]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Feb 23 22:43:30 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 23 22:43:33 studio sudo[2907]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:43:33 studio sudo[2907]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:33 studio sudo[2907]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:33 studio sudo[2909]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:43:33 studio sudo[2909]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:33 studio sudo[2909]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:33 studio sudo[2913]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Feb 23 22:43:33 studio sudo[2913]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Feb 23 22:43:34 studio volumio[2456]: info: Adding plugin bluetooth to MyMusic Plugins Feb 23 22:43:34 studio volumio[2456]: info: Adding plugin multiroom to MyMusic Plugins Feb 23 22:43:34 studio volumio[2456]: info: Adding plugin metavolumio to MyMusic Plugins Feb 23 22:43:34 studio volumio[2456]: info: Adding plugin cd_controller to MyMusic Plugins Feb 23 22:43:34 studio volumio[2456]: info: Adding plugin qobuzconnect to MyMusic Plugins Feb 23 22:43:34 studio volumio[2456]: info: Adding plugin smart_inputs to MyMusic Plugins Feb 23 22:43:34 studio volumio[2456]: info: Adding plugin tidalconnect to MyMusic Plugins Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Feb 23 22:43:34 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:34 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:34 studio volumio[2456]: info: Starting MyVolumio Remote Streaming Endpoints Feb 23 22:43:34 studio volumio[2456]: info: MyVolumio login type: Token Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Feb 23 22:43:34 studio volumio[2456]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Feb 23 22:43:35 studio volumio[2456]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Feb 23 22:43:35 studio volumio[2456]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Feb 23 22:43:35 studio volumio[2456]: info: Streaming services startup Feb 23 22:43:35 studio volumio[2456]: info: Starting Streaming Daemon Feb 23 22:43:35 studio sudo[2917]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 23 22:43:35 studio sudo[2917]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:35 studio volumio[2456]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Feb 23 22:43:35 studio sudo[2917]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:35 studio volumio[2456]: error: Cannot start Volumio Streaming Daemon Feb 23 22:43:35 studio volumio[2456]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 23 22:43:35 studio volumio[2456]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 23 22:43:35 studio volumio[2456]: error: MyVolumio Custom Token format not valid, refreshing it Feb 23 22:43:36 studio volumio[2456]: info: MyVolumio login type: Token Feb 23 22:43:36 studio volumio[2456]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 23 22:43:37 studio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Feb 23 22:43:37 studio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 22:43:37 studio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Feb 23 22:43:37 studio systemd[1]: Reached target multi-user.target - Multi-User System. Feb 23 22:43:37 studio systemd[1]: Reached target graphical.target - Graphical Interface. Feb 23 22:43:37 studio sudo[2913]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:37 studio systemd[1]: Starting systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP... Feb 23 22:43:37 studio volumio[2456]: info: Upmpdcli Daemon Started Feb 23 22:43:37 studio systemd[1]: systemd-update-utmp-runlevel.service: Deactivated successfully. Feb 23 22:43:37 studio systemd[1]: Finished systemd-update-utmp-runlevel.service - Record Runlevel Change in UTMP. Feb 23 22:43:37 studio systemd[1]: Startup finished in 11.651s (kernel) + 48.108s (userspace) = 59.760s. Feb 23 22:43:37 studio volumio[2456]: info: MyVolumio token set successfully Feb 23 22:43:37 studio volumio[2456]: info: MYVOLUMIO: Adding device Feb 23 22:43:37 studio volumio[2456]: info: MYVOLUMIO: Evaluating Server Feb 23 22:43:37 studio volumio[2456]: info: MyVolumio status changed Feb 23 22:43:37 studio volumio[2456]: info: Streaming services startup Feb 23 22:43:37 studio volumio[2456]: info: Starting Streaming Daemon Feb 23 22:43:37 studio volumio[2456]: info: Removing browser output: myVolumio user plan is not superstar Feb 23 22:43:37 studio volumio[2456]: info: Removing audio output: Feb 23 22:43:37 studio volumio[2456]: info: Stoppping Tunnel 1 Feb 23 22:43:37 studio sudo[2962]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 23 22:43:37 studio sudo[2962]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:37 studio sudo[2964]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 23 22:43:37 studio sudo[2964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:43:37 studio sudo[2962]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio volumio[2456]: error: Cannot start Volumio Streaming Daemon Feb 23 22:43:37 studio volumio[2456]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Feb 23 22:43:37 studio volumio[2456]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Feb 23 22:43:37 studio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio 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. Feb 23 22:43:37 studio sudo[2964]: pam_unix(sudo:session): session closed for user root Feb 23 22:43:37 studio volumio[2456]: info: Remote SSH Stopped Feb 23 22:43:37 studio volumio[2456]: info: Setting Geolocation for MyVolumio to eu3 Feb 23 22:43:37 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:37 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:37 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:38 studio systemd[1]: setdatetime-helper.service: Deactivated successfully. Feb 23 22:43:38 studio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 22:43:38 studio volumio[2456]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 23 22:43:38 studio volumio[2456]: info: Received Get System Version Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:38 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:38 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:38 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:38 studio volumio[2456]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 23 22:43:38 studio volumio[2456]: info: Updating MyVolumio device info Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:38 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:39 studio volumio[2456]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 23 22:43:40 studio upmpdcli[2992]: writing RSA key Feb 23 22:43:42 studio volumio[2456]: info: MYVOLUMIO: Adding device Feb 23 22:43:42 studio volumio[2456]: info: MYVOLUMIO: Evaluating Server Feb 23 22:43:42 studio volumio[2456]: info: Setting Geolocation for MyVolumio to eu8 Feb 23 22:43:42 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:42 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:42 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:43 studio volumio[2456]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Feb 23 22:43:43 studio volumio[2456]: info: Updating MyVolumio device info Feb 23 22:43:43 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:43 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:43 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:44 studio volumio[2456]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 23 22:43:49 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 22:43:49 studio volumio[2456]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Feb 23 22:43:49 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:49 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:54 studio volumio5-onboarding[2487]: failed to bootstrap state: failed to check for software update: could not check for updates: context deadline exceeded Feb 23 22:43:54 studio systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Feb 23 22:43:54 studio systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::volumioGetBrowseSources Feb 23 22:43:54 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:55 studio systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Feb 23 22:43:55 studio systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 23 22:43:55 studio systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Feb 23 22:43:55 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:55.098Z level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z Feb 23 22:43:55 studio volumio[2456]: 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: 9 Feb 23 22:43:55 studio volumio[2456]: 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: 9 Feb 23 22:43:55 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:55 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:55 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:55 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:55.108Z level=INFO msg="system info for 7805e7534090a9fbfd3fb6aa972f7c8a" deviceName=Studio deviceVariant=volumio deviceModel= softwareVersion=4.096 Feb 23 22:43:55 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:55 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:55 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 22:43:55 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:55.126Z level=INFO msg="enabling local network discovery" Feb 23 22:43:55 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:55.146Z level=INFO msg="bootstrapping state" hasInternet=true Feb 23 22:43:55 studio volumio[2456]: info: Received Get System Info Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:55 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:55 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:55 studio volumio-remote-updater[910]: Test mode disabled Feb 23 22:43:55 studio volumio-remote-updater[910]: Alpha mode disabled Feb 23 22:43:55 studio volumio-remote-updater[910]: Alpha legacy test mode disabled Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 22:43:55 studio volumio[2456]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 23 22:43:55 studio volumio-remote-updater[910]: Test mode disabled Feb 23 22:43:55 studio volumio-remote-updater[910]: Alpha mode disabled Feb 23 22:43:55 studio volumio-remote-updater[910]: Alpha legacy test mode disabled Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Feb 23 22:43:55 studio volumio[2456]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Feb 23 22:43:55 studio volumio[2456]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 23 22:43:55 studio volumio[2456]: info: Completed starting MyVolumio Plugin Feb 23 22:43:55 studio volumio[2456]: [Metrics] CommandRouter: 32s 127.43ms Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::volumiosetStartupVolume Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::Close All Modals sent Feb 23 22:43:55 studio volumio[2456]: info: CoreCommandRouter::Close All Modals sent Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:43:56 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:43:56 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:43:56 studio volumio[2456]: verbose: New Socket.io Connection to 192.168.0.236:3000 from 192.168.0.198 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 10 Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 22:43:56 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 22:43:58 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:58.333Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=tidal error="could not open plugin config file for \"tidal\": open /data/configuration/music_service/tidal/config.json: no such file or directory" Feb 23 22:43:58 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:58.334Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=qobuz error="could not open plugin config file for \"qobuz\": open /data/configuration/music_service/qobuz/config.json: no such file or directory" Feb 23 22:43:58 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:58.334Z level=WARN msg="could not read username/password data for music provider" component=volumio provider=hi_res_audio error="could not open plugin config file for \"hi_res_audio\": open /data/configuration/music_service/hi_res_audio/config.json: no such file or directory" Feb 23 22:43:58 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:58.334Z level=WARN msg="could not read OAuth data for music provider" component=volumio provider=spotify error="could not open plugin config file for \"spop\": open /data/configuration/music_service/spop/config.json: no such file or directory" Feb 23 22:43:58 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:43:58 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:43:58 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 23 22:43:59 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:43:59 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 23 22:43:59 studio volumio5-onboarding[3042]: time=2026-02-23T22:43:59.779Z level=INFO msg="authenticated Firebase client" component=volumio/firebase userId=9uKjtW4NqlgpJsmKL9SvO1jh6Na2 tokenExpiry=2026-02-23T23:43:59.779Z Feb 23 22:44:01 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:01.969Z level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.0.198:39738 Feb 23 22:44:02 studio volumio[2456]: info: BOOT COMPLETED Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.582Z level=INFO msg="device data request" component=server type=REQUEST_TYPE_DEVICE_DATA peer="192.168.0.198:39738 @ 0x1c00b70" latency=-1.233435034s timeout=10s Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.582Z level=INFO msg="emitting device capabilities changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.582Z level=INFO msg="app ready event" component=server event=CLIENT_EVENT_TYPE_APP_READY peer="192.168.0.198:39738 @ 0x1c00b70" latency=-1.232426664s platform=PLATFORM_ANDROID version=5.260120.0 Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 23 22:44:04 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:04 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:04 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.585Z level=INFO msg="emitting device name changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" name=Studio Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.586Z level=INFO msg="emitting device language changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" language=en Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getCurrentTimezone Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.588Z level=INFO msg="emitting device timezone changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" timezone=Europe/London Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.588Z level=INFO msg="emitting ethernet info changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" available=true connected=false macAddress= ip4Address= ip6Address= Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.589Z level=INFO msg="emitting wifi info changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.589Z level=INFO msg="emitting device setup status changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" setupComplete=true Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getExtendedOutputDevices Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 22:44:04 studio volumio[2456]: amixer -c 0 info | grep "vc4-hdmi-0" Feb 23 22:44:04 studio volumio[2456]: Card sysdefault:0 'vc4hdmi0'/'vc4-hdmi-0' Feb 23 22:44:04 studio volumio[2456]: amixer -c 1 info | grep "vc4-hdmi-1" Feb 23 22:44:04 studio volumio[2456]: Card sysdefault:1 'vc4hdmi1'/'vc4-hdmi-1' Feb 23 22:44:04 studio volumio[2456]: amixer -c 2 info | grep "snd_rpi_hifiberry_dac" Feb 23 22:44:04 studio volumio[2456]: Card sysdefault:2 'sndrpihifiberry'/'snd_rpi_hifiberry_dac' Feb 23 22:44:04 studio volumio[2456]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 7 Feb 23 22:44:04 studio volumio[2456]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 23 22:44:04 studio volumio[2456]: {"cmd":"/usr/local/bin/alsacap -C 7","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 7\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 23 22:44:04 studio volumio[2456]: amixer -c 7 info | grep "Dummy" Feb 23 22:44:04 studio volumio[2456]: Card sysdefault:7 'Dummy'/'Dummy 1' Feb 23 22:44:04 studio volumio[2456]: Mixer name : 'Dummy Mixer' Feb 23 22:44:04 studio volumio[2456]: error: Cannot read Audio Device Capabilities Command failed: /usr/local/bin/alsacap -C 2 Feb 23 22:44:04 studio volumio[2456]: /bin/sh: 1: /usr/local/bin/alsacap: not found Feb 23 22:44:04 studio volumio[2456]: {"cmd":"/usr/local/bin/alsacap -C 2","code":127,"killed":false,"signal":null,"stack":"Error: Command failed: /usr/local/bin/alsacap -C 2\n/bin/sh: 1: /usr/local/bin/alsacap: not found\n\n at ChildProcess.exithandler (node:child_process:421:12)\n at ChildProcess.emit (node:events:514:28)\n at maybeClose (node:internal/child_process:1105:16)\n at Socket. (node:internal/child_process:457:11)\n at Socket.emit (node:events:514:28)\n at Pipe. (node:net:337:12)"} Feb 23 22:44:04 studio volumio[2456]: amixer -c 2 info | grep "Generic I2S DAC" Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.645Z level=INFO msg="emitting audio outputs changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" selectedOutputId=2 Feb 23 22:44:04 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:04 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:04 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.662Z level=INFO msg="emitting software info changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" currentVersion=4.096 latestVersion=4.096 Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.662Z level=INFO msg="emitting software update progress event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" status=UPDATE_STATUS_NONE progress=0 Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.662Z level=INFO msg="emitting user changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" userId=9uKjtW4NqlgpJsmKL9SvO1jh6Na2 Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.662Z level=INFO msg="emitting music providers changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" providers=9 Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.662Z level=INFO msg="emitting plugins changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" plugins=60 Feb 23 22:44:04 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:04 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.664Z level=INFO msg="emitting player state changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" state=STATUS_STOPPED positionMs=0 volume=67 Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.665Z level=INFO msg="emitting player metadata changed event" component=server peer="192.168.0.198:39738 @ 0x1c00b70" id="music-library/USB/Samsung_USB/Orchestral Manoeuvres in the Dark/In the Dark; The Best of OMD – (1988)/01 – Electricity.flac" title=Electricity Feb 23 22:44:04 studio volumio5-onboarding[3042]: time=2026-02-23T22:44:04.697Z level=INFO msg="navigate to next page" component=server type=REQUEST_TYPE_CONTINUE_NAVIGATION peer="192.168.0.198:39738 @ 0x1c00b70" latency=-1.231901169s timeout=10s from=APP_PAGE_ROOT to=APP_PAGE_LEGACY_DEVICE Feb 23 22:44:05 studio sudo[3105]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:44:05 studio sudo[3105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:05 studio sudo[3107]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:44:05 studio sudo[3105]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:05 studio sudo[3107]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:05 studio sudo[3107]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:05 studio volumio[2456]: verbose: New Socket.io Connection to 192.168.0.236 from 192.168.0.198 UA: Mozilla/5.0 (Linux; Android 15; moto g75 5G Build/V1UQS35H.103-16-10; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.132 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 22:44:06 studio sudo[3111]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:44:06 studio sudo[3111]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:06 studio sudo[3111]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:06 studio sudo[3113]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:44:06 studio sudo[3113]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:06 studio sudo[3113]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:06 studio volumio[2456]: verbose: New Socket.io Connection to 192.168.0.236 from 192.168.0.198 UA: Mozilla/5.0 (Linux; Android 15; moto g75 5G Build/V1UQS35H.103-16-10; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.132 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:06 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 22:44:06 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:06 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:06 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:06 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:06 studio volumio[2456]: info: Listing playlists Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 22:44:06 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 22:44:08 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 22:44:08 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:44:08 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:08 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:08 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:08 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:08 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:08 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:08 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:08 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 23 22:44:08 studio sudo[3117]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:44:08 studio sudo[3117]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:08 studio sudo[3117]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:08 studio sudo[3119]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:44:08 studio sudo[3119]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:08 studio sudo[3119]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:08 studio volumio[2456]: verbose: New Socket.io Connection to 192.168.0.236 from 192.168.0.198 UA: Mozilla/5.0 (Linux; Android 15; moto g75 5G Build/V1UQS35H.103-16-10; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.132 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Feb 23 22:44:08 studio sudo[3123]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:44:08 studio sudo[3123]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:08 studio sudo[3123]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:08 studio sudo[3125]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:44:08 studio sudo[3125]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:08 studio sudo[3125]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:08 studio volumio[2456]: verbose: New Socket.io Connection to 192.168.0.236 from 192.168.0.198 UA: Mozilla/5.0 (Linux; Android 15; moto g75 5G Build/V1UQS35H.103-16-10; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.132 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::volumioGetVisibleSources Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:09 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 23 22:44:09 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:09 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:09 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:09 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:09 studio volumio[2456]: info: Listing playlists Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 22:44:09 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 23 22:44:10 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 23 22:44:10 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:44:10 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:10 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:10 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:10 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:10 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:10 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:10 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:10 studio volumio[2456]: info: CoreCommandRouter::volumioGetQueue Feb 23 22:44:10 studio volumio[2456]: info: CoreStateMachine::getQueue Feb 23 22:44:10 studio volumio[2456]: info: CorePlayQueue::getQueue Feb 23 22:44:11 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 22:44:11 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:11 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:11 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:11 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:11 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:11 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:11 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:12 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 23 22:44:12 studio volumio[2456]: info: CURURI: artists:// Feb 23 22:44:12 studio volumio[2456]: info: Preload queue cleared Feb 23 22:44:18 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 23 22:44:27 studio sudo[3248]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:44:27 studio sudo[3248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:27 studio sudo[3248]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:27 studio sudo[3250]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:44:27 studio sudo[3250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:27 studio sudo[3250]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:27 studio volumio[2456]: verbose: New Socket.io Connection to 192.168.0.236 from 192.168.0.198 UA: Mozilla/5.0 (Linux; Android 15; moto g75 5G Build/V1UQS35H.103-16-10; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.132 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Feb 23 22:44:27 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 23 22:44:27 studio volumio[2456]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 23 22:44:27 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 23 22:44:27 studio volumio[2456]: info: Received Get System Version Feb 23 22:44:27 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 23 22:44:27 studio volumio[2456]: info: Received Get System Info Feb 23 22:44:27 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 23 22:44:27 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 23 22:44:27 studio volumio[2456]: info: Discovery: Getting this device information Feb 23 22:44:27 studio volumio[2456]: info: CoreCommandRouter::volumioGetState Feb 23 22:44:27 studio volumio[2456]: info: CorePlayQueue::getTrack 0 Feb 23 22:44:27 studio volumio[2456]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 22:44:27 studio sudo[3254]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 23 22:44:27 studio sudo[3254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:27 studio sudo[3256]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 23 22:44:27 studio sudo[3256]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 23 22:44:27 studio sudo[3254]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:27 studio sudo[3256]: pam_unix(sudo:session): session closed for user root Feb 23 22:44:27 studio volumio[2456]: verbose: New Socket.io Connection to 192.168.0.236 from 192.168.0.198 UA: Mozilla/5.0 (Linux; Android 15; moto g75 5G Build/V1UQS35H.103-16-10; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/144.0.7559.132 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 14 Feb 23 22:44:28 studio volumio[2456]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 22:44:28 studio volumio[2456]: TypeError: Cannot read properties of null (reading 'slice') Feb 23 22:44:28 studio volumio[2456]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 23 22:44:28 studio volumio[2456]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 23 22:44:28 studio volumio[2456]: at Object.onceWrapper (node:events:629:26) Feb 23 22:44:28 studio volumio[2456]: at ClientRequest.emit (node:events:514:28) Feb 23 22:44:28 studio volumio[2456]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27) Feb 23 22:44:28 studio volumio[2456]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17) Feb 23 22:44:28 studio volumio[2456]: at TLSSocket.socketOnData (node:_http_client:535:22) Feb 23 22:44:28 studio volumio[2456]: at TLSSocket.emit (node:events:514:28) Feb 23 22:44:28 studio volumio[2456]: at addChunk (node:internal/streams/readable:343:12) Feb 23 22:44:28 studio volumio[2456]: at readableAddChunk (node:internal/streams/readable:316:9) Feb 23 22:44:28 studio volumio[2456]: at Readable.push (node:internal/streams/readable:253:10) Feb 23 22:44:28 studio volumio[2456]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23) Feb 23 22:44:28 studio volumio[2456]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 22:44:28 studio sudo[3273]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-23 22:43' Feb 23 22:44:28 studio sudo[3273]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"