Oct 14 17:59:01 volumio2 volumio[1285]: info: MYVOLUMIO Environment detected Oct 14 17:59:01 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 13. Oct 14 17:59:01 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:01 volumio2 (cava)[1573]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:01 volumio2 (cava)[1573]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:01 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:01 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:01 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:02 volumio2 volumio[1285]: info: Plugin folders cleanup Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning into folder /volumio/app/plugins/ Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning category audio_interface Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning category miscellanea Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning category music_service Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning category plugins.json Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning category system_controller Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning category user_interface Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning into folder /data/plugins/ Oct 14 17:59:02 volumio2 volumio[1285]: info: Scanning category system_hardware Oct 14 17:59:02 volumio2 volumio[1285]: info: Plugin folders cleanup completed Oct 14 17:59:02 volumio2 volumio[1285]: info: ------------------------------------------- Oct 14 17:59:02 volumio2 volumio[1285]: info: ----- Core plugins startup ---- Oct 14 17:59:02 volumio2 volumio[1285]: info: ------------------------------------------- Oct 14 17:59:02 volumio2 volumio[1285]: info: Loading plugins from folder /volumio/app/plugins/ Oct 14 17:59:02 volumio2 volumio[1285]: info: Adding plugin upnp to MyMusic Plugins Oct 14 17:59:02 volumio2 volumio[1285]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 14 17:59:02 volumio2 volumio[1285]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 14 17:59:02 volumio2 volumio[1285]: info: Loading plugins from folder /data/plugins/ Oct 14 17:59:02 volumio2 volumio[1285]: info: Loading plugin "system"... Oct 14 17:59:02 volumio2 volumio[1285]: info: Loading plugin "appearance"... Oct 14 17:59:03 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 17:59:04 volumio2 volumio-remote-updater[672]: [2026-10-14 17:59:04] [connect] Successful connection Oct 14 17:59:05 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 14. Oct 14 17:59:05 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:05 volumio2 (cava)[1577]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:05 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:05 volumio2 (cava)[1577]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:05 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:05 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:05 volumio2 volumio[1285]: info: Loading plugin "network"... Oct 14 17:59:05 volumio2 volumio[1285]: info: Refreshing Cached IP Addresses Oct 14 17:59:05 volumio2 volumio[1285]: info: Loading plugin "services"... Oct 14 17:59:05 volumio2 volumio[1285]: info: Loading plugin "volumio5onboarding"... Oct 14 17:59:05 volumio2 sudo[1582]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 14 17:59:05 volumio2 sudo[1582]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:06 volumio2 sudo[1582]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:06 volumio2 sudo[1579]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 14 17:59:06 volumio2 sudo[1579]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:06 volumio2 volumio[1285]: info: Loading plugin "alsa_controller"... Oct 14 17:59:06 volumio2 sudo[1579]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:06 volumio2 sudo[1590]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 14 17:59:06 volumio2 sudo[1590]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:06 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 17:59:06 volumio2 volumio[1285]: info: Loading plugin "wizard"... Oct 14 17:59:06 volumio2 volumio[1285]: info: Loading plugin "networkfs"... Oct 14 17:59:06 volumio2 volumio[1285]: info: Starting Udev Watcher for removable devices Oct 14 17:59:06 volumio2 volumio[1285]: info: Ignoring mount for partition: boot Oct 14 17:59:06 volumio2 volumio[1285]: info: Ignoring mount for partition: volumio Oct 14 17:59:06 volumio2 volumio[1285]: info: Ignoring mount for partition: volumio_data Oct 14 17:59:06 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 14 17:59:06 volumio2 volumio[1285]: info: Loading plugin "volumio_command_line_client"... Oct 14 17:59:06 volumio2 sudo[1613]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=qnap_reader,password=qnap_reader,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.10.222/music\\music /mnt/NAS/QNAP Oct 14 17:59:06 volumio2 sudo[1613]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:06 volumio2 volumio[1285]: info: Plugin upnp is not enabled Oct 14 17:59:06 volumio2 volumio[1285]: info: Loading plugin "my_music"... Oct 14 17:59:06 volumio2 volumio[1285]: info: Loading plugin "mpd"... Oct 14 17:59:07 volumio2 kernel: netfs: FS-Cache loaded Oct 14 17:59:07 volumio2 kernel: Key type cifs.spnego registered Oct 14 17:59:07 volumio2 kernel: Key type cifs.idmap registered Oct 14 17:59:07 volumio2 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 14 17:59:07 volumio2 kernel: CIFS: Attempting to mount //192.168.10.222/music/music Oct 14 17:59:08 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 3. Oct 14 17:59:08 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 15. Oct 14 17:59:08 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:08 volumio2 (cava)[1640]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:08 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:08 volumio2 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 17:59:08 volumio2 (cava)[1640]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:08 volumio2 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 17:59:08 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:08 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:08 volumio2 upmpdcli[1645]: Could not open config: /tmp/upmpdcli.conf Oct 14 17:59:08 volumio2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 14 17:59:08 volumio2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 14 17:59:08 volumio2 volumio[1285]: info: Loading plugin "upnp_browser"... Oct 14 17:59:09 volumio2 sudo[1613]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:09 volumio2 sudo[1590]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:11 volumio2 python3[870]: 2026-10-14 17:59:11,167 - VolumioListener - INFO - [VolumioListener] Connecting to Volumio at localhost:3000... Oct 14 17:59:11 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 16. Oct 14 17:59:11 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:12 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:12 volumio2 (cava)[1652]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:12 volumio2 (cava)[1652]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:12 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:12 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:13 volumio2 volumio[1285]: info: Starting UPNP Browser Oct 14 17:59:13 volumio2 volumio[1285]: info: Loading plugin "alarm-clock"... Oct 14 17:59:13 volumio2 volumio[1285]: info: Loading plugin "airplay_emulation"... Oct 14 17:59:13 volumio2 volumio[1285]: info: Starting Shairport Sync Oct 14 17:59:13 volumio2 volumio[1285]: info: Loading plugin "last_100"... Oct 14 17:59:13 volumio2 volumio[1285]: info: Loading plugin "webradio"... Oct 14 17:59:14 volumio2 volumio[1285]: info: Loading plugin "i2s_dacs"... Oct 14 17:59:14 volumio2 volumio[1285]: info: Loading plugin "volumiodiscovery"... Oct 14 17:59:14 volumio2 volumio[1285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 14 17:59:14 volumio2 volumio[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 14 17:59:14 volumio2 volumio[1285]: *** WARNING *** For more information see Oct 14 17:59:14 volumio2 volumio[1285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 14 17:59:14 volumio2 volumio[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 14 17:59:14 volumio2 volumio[1285]: *** WARNING *** For more information see Oct 14 17:59:14 volumio2 node[1285]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 14 17:59:14 volumio2 node[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 14 17:59:14 volumio2 node[1285]: *** WARNING *** For more information see Oct 14 17:59:14 volumio2 node[1285]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 14 17:59:14 volumio2 node[1285]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 14 17:59:14 volumio2 node[1285]: *** WARNING *** For more information see Oct 14 17:59:14 volumio2 volumio[1285]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 14 17:59:14 volumio2 volumio[1285]: info: Discovery: Started advertising with name: Volumio2 Oct 14 17:59:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 14 17:59:14 volumio2 volumio[1285]: info: Loading plugin "outputs"... Oct 14 17:59:14 volumio2 volumio[1285]: info: Loading plugin "albumart"... Oct 14 17:59:14 volumio2 volumio[1285]: info: Plugin example_plugin is not enabled Oct 14 17:59:14 volumio2 volumio[1285]: info: Loading plugin "inputs"... Oct 14 17:59:14 volumio2 volumio[1285]: info: Loading plugin "updater_comm"... Oct 14 17:59:15 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 17. Oct 14 17:59:15 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:15 volumio2 (cava)[1665]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:15 volumio2 (cava)[1665]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:15 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:15 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:15 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:15 volumio2 volumio[1285]: info: Plugin mpdemulation is not enabled Oct 14 17:59:15 volumio2 volumio[1285]: info: Loading plugin "rest_api"... Oct 14 17:59:15 volumio2 volumio[1285]: info: Loading plugin "websocket"... Oct 14 17:59:15 volumio2 volumio[1285]: info: Starting Socket.io Server version 1.7.4 Oct 14 17:59:15 volumio2 volumio[1285]: info: Loading plugin "quadify"... Oct 14 17:59:16 volumio2 python3[870]: 2026-10-14 17:59:16,195 - VolumioListener - ERROR - [VolumioListener] Connection error: Connection refused by the server Oct 14 17:59:16 volumio2 python3[870]: 2026-10-14 17:59:16,195 - VolumioListener - INFO - [VolumioListener] Reconnecting in 20 seconds... Oct 14 17:59:17 volumio2 volumio[1655]: Forking 3 albumart workers Oct 14 17:59:18 volumio2 volumio[1285]: info: [Quadify] onVolumioStart – ensure config Oct 14 17:59:18 volumio2 volumio[1285]: info: Loading plugin "rotaryencoder2"... Oct 14 17:59:18 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 18. Oct 14 17:59:18 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:18 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:18 volumio2 (cava)[1700]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:18 volumio2 (cava)[1700]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:18 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:18 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:19 volumio2 volumio-remote-updater[672]: [2026-10-14 17:59:19] [connect] Successful connection Oct 14 17:59:21 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 19. Oct 14 17:59:21 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:21 volumio2 (cava)[1712]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:21 volumio2 (cava)[1712]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:21 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:21 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:21 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:23 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Oct 14 17:59:23 volumio2 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 17:59:23 volumio2 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 17:59:24 volumio2 upmpdcli[1713]: Could not open config: /tmp/upmpdcli.conf Oct 14 17:59:24 volumio2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 14 17:59:24 volumio2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 14 17:59:24 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 20. Oct 14 17:59:24 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:24 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:24 volumio2 (cava)[1714]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:24 volumio2 (cava)[1714]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:24 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:24 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:25 volumio2 volumio[1285]: info: Loading i18n strings for locale de Oct 14 17:59:25 volumio2 volumio[1285]: Updating browse sources language Oct 14 17:59:25 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::initPlayerControls Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 17:59:27 volumio2 volumio[1285]: Express server listening on port 3000 Oct 14 17:59:28 volumio2 volumio[1285]: [Metrics] WebUI: 31s 483.75ms Oct 14 17:59:28 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 21. Oct 14 17:59:28 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:28 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:28 volumio2 (cava)[1730]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:28 volumio2 (cava)[1730]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:28 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:28 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:28 volumio2 volumio[1285]: info: CoreStateMachine::resetVolumioState Oct 14 17:59:28 volumio2 volumio[1285]: info: CoreStateMachine::getcurrentVolume Oct 14 17:59:28 volumio2 volumio[1285]: info: CoreCommandRouter::volumioRetrievevolume Oct 14 17:59:29 volumio2 volumio[1285]: info: Volumio Network Manager: Network status updated: 2 Oct 14 17:59:31 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 22. Oct 14 17:59:31 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:31 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:31 volumio2 (cava)[1735]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:31 volumio2 (cava)[1735]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:31 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:31 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:31 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 1 Oct 14 17:59:32 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Oct 14 17:59:32 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Oct 14 17:59:33 volumio2 volumio[1285]: info: Reloading queue from file Oct 14 17:59:33 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 17:59:33 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Oct 14 17:59:34 volumio2 volumio-remote-updater[672]: [2026-10-14 17:59:34] [connect] Successful connection Oct 14 17:59:34 volumio2 volumio[1285]: info: VolumeController:: Volume=52 Mute =false Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreStateMachine::pushState Oct 14 17:59:34 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 17:59:34 volumio2 volumio[1683]: Starting albumart workers Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreCommandRouter::volumioPushState Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreStateMachine::updateTrackBlock Oct 14 17:59:34 volumio2 volumio[1285]: info: CorePlayQueue::getTrackBlock Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreCommandRouter::volumioRetrievevolume Oct 14 17:59:34 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 23. Oct 14 17:59:34 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:34 volumio2 (cava)[1744]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:34 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:34 volumio2 (cava)[1744]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:34 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:34 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:34 volumio2 volumio[1285]: info: Setting Device type: Raspberry PI Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreStateMachine::setRepeat null single undefined Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreStateMachine::pushState Oct 14 17:59:34 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreCommandRouter::volumioPushState Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreStateMachine::setRandom null Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreStateMachine::pushState Oct 14 17:59:34 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:34 volumio2 volumio[1285]: info: CoreCommandRouter::volumioPushState Oct 14 17:59:35 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 14 17:59:35 volumio2 volumio[1285]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.34.2 Engine version: 3 Transport: polling Total Clients: 6 Oct 14 17:59:35 volumio2 volumio[1682]: Starting albumart workers Oct 14 17:59:36 volumio2 python3[870]: 2026-10-14 17:59:36,197 - VolumioListener - INFO - [VolumioListener] Connecting to Volumio at localhost:3000... Oct 14 17:59:36 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 Oct 14 17:59:36 volumio2 volumio[1285]: info: Discovery: adding a215eb68-0bc4-48de-bd94-91c5a81c0edf Oct 14 17:59:36 volumio2 volumio[1285]: info: Discovery: Found device Volumio2 Oct 14 17:59:36 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 17:59:36 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:36 volumio2 volumio[1285]: info: Discovery: this is already registered, a215eb68-0bc4-48de-bd94-91c5a81c0edf Oct 14 17:59:36 volumio2 volumio[1285]: info: Discovery: Found device Volumio2 Oct 14 17:59:36 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 17:59:36 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:36 volumio2 volumio[1285]: info: VolumeController:: Volume=52 Mute =false Oct 14 17:59:36 volumio2 volumio[1285]: info: CoreStateMachine::pushState Oct 14 17:59:36 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:36 volumio2 volumio[1285]: info: CoreCommandRouter::volumioPushState Oct 14 17:59:37 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 14 17:59:37 volumio2 volumio[1285]: info: Discovery: this is already registered, a215eb68-0bc4-48de-bd94-91c5a81c0edf Oct 14 17:59:37 volumio2 volumio[1285]: info: Discovery: Found device Volumio Oct 14 17:59:37 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 17:59:37 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:37 volumio2 volumio[1681]: Starting albumart workers Oct 14 17:59:37 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 14 17:59:37 volumio2 volumio-remote-updater[672]: [2026-10-14 17:59:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1791993574 101 Oct 14 17:59:37 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 24. Oct 14 17:59:37 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:37 volumio2 volumio[1285]: 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: 10 Oct 14 17:59:37 volumio2 (cava)[1764]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:37 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:37 volumio2 (cava)[1764]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:37 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:37 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:38 volumio2 volumio[1285]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.34.2 Engine version: 3 Transport: polling Total Clients: 11 Oct 14 17:59:39 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Oct 14 17:59:39 volumio2 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 17:59:39 volumio2 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 17:59:39 volumio2 upmpdcli[1766]: Could not open config: /tmp/upmpdcli.conf Oct 14 17:59:39 volumio2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 14 17:59:39 volumio2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 14 17:59:39 volumio2 python3[870]: 2026-10-14 17:59:39,469 - VolumioListener - INFO - [VolumioListener] Successfully connected. Oct 14 17:59:39 volumio2 python3[870]: 2026-10-14 17:59:39,894 - VolumioListener - INFO - [VolumioListener] Connected to Volumio. Oct 14 17:59:40 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 17:59:40 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:40 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 14 17:59:40 volumio2 volumio[1285]: info: CURURI: music-library Oct 14 17:59:40 volumio2 volumio[1285]: error: Failed to execute browseSource, failure: TypeError: Cannot read properties of undefined (reading 'then') Oct 14 17:59:40 volumio2 python3[870]: 2026-10-14 17:59:40,447 - ModeManager - DEBUG - ModeManager: process_state_change => {'status': 'stop', 'position': 0, 'title': 'Showdown', 'artist': 'Electric Light Orchestra', 'album': 'Definitive Collection', 'albumart': '/albumart?cacheid=401&web=Electric%20Light%20Orchestra/Definitive%20Collection/extralarge&path=%2FNAS%2FQNAP%2FElectric%20Light%20Orchestra%2FDefinitive%20Collection&metadata=false', 'uri': 'mnt/NAS/QNAP/Electric Light Orchestra/Definitive Collection/01 Showdown.m4a', 'trackType': 'm4a', 'seek': 0, 'duration': 251, 'random': None, 'repeat': None, 'repeatSingle': False, 'consume': False, 'volume': 52, 'dbVolume': None, 'disableVolumeControl': False, 'mute': False, 'stream': 'm4a', 'updatedb': False, 'volatile': False, 'service': 'mpd'} Oct 14 17:59:40 volumio2 python3[870]: 2026-10-14 17:59:40,448 - ModeManager - DEBUG - ModeManager: Skipping pause/stop timer after initial handoff. Oct 14 17:59:40 volumio2 python3[870]: 2026-10-14 17:59:40,449 - ModeManager - DEBUG - ModeManager: Completed process_state_change. Oct 14 17:59:41 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 25. Oct 14 17:59:41 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:41 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:41 volumio2 (cava)[1775]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:41 volumio2 (cava)[1775]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:41 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:41 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:41 volumio2 sudo[1777]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 14 17:59:41 volumio2 sudo[1777]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:41 volumio2 sudo[1777]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:41 volumio2 sudo[1779]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 14 17:59:41 volumio2 sudo[1779]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:41 volumio2 sudo[1779]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:42 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 12 Oct 14 17:59:42 volumio2 volumio[1285]: info: [Quadify] CMD OK: /bin/systemctl show -p LoadState -p FragmentPath quadify-buttonsleds.service Oct 14 17:59:42 volumio2 volumio[1285]: stdout: LoadState=loaded Oct 14 17:59:42 volumio2 volumio[1285]: FragmentPath=/etc/systemd/system/quadify-buttonsleds.service Oct 14 17:59:42 volumio2 volumio[1285]: stderr: Oct 14 17:59:42 volumio2 volumio[1285]: info: [Quadify][DETECT] quadify-buttonsleds.service load=loaded path=/etc/systemd/system/quadify-buttonsleds.service Oct 14 17:59:42 volumio2 volumio[1285]: info: [Quadify][DETECT] using unit=quadify-buttonsleds Oct 14 17:59:43 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 17:59:43 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 17:59:43 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 17:59:43 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:43 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 14 17:59:43 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 14 17:59:43 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 14 17:59:43 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 14 17:59:43 volumio2 volumio[1285]: info: [Quadify] CMD OK: /bin/systemctl show -p LoadState -p FragmentPath quadify-buttonsleds.service Oct 14 17:59:43 volumio2 volumio[1285]: stdout: LoadState=loaded Oct 14 17:59:43 volumio2 volumio[1285]: FragmentPath=/etc/systemd/system/quadify-buttonsleds.service Oct 14 17:59:43 volumio2 volumio[1285]: stderr: Oct 14 17:59:43 volumio2 volumio[1285]: info: [Quadify][DETECT] quadify-buttonsleds.service load=loaded path=/etc/systemd/system/quadify-buttonsleds.service Oct 14 17:59:43 volumio2 volumio[1285]: info: [Quadify][DETECT] using unit=quadify-buttonsleds Oct 14 17:59:43 volumio2 volumio[1285]: info: [Quadify][TOGGLE] want: cava=true buttons=false ir=false safety=true (btnUnit=quadify-buttonsleds) screen=vuscreen rotate=180 mcp=20 Oct 14 17:59:44 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 26. Oct 14 17:59:44 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:44 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 17:59:44 volumio2 (cava)[1804]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:44 volumio2 (cava)[1804]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 17:59:44 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 17:59:44 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 17:59:44 volumio2 sudo[1808]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 14 17:59:44 volumio2 sudo[1808]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:44 volumio2 sudo[1808]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:44 volumio2 sudo[1806]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 14 17:59:44 volumio2 sudo[1806]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:44 volumio2 sudo[1806]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:45 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 13 Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify][SNAPSHOT] pre-toggles :: pref{spec=true,screen=vuscreen,rot=180} flat{spec=undefined,screen=undefined,rot=undefined} yaml{mcp=32,rot=} units{cava=activating/enabled, quadify-buttonsleds=inactive/disabled, lircd=active/disabled, ir_listener=inactive/disabled} Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify][TOGGLE] CAVA => enable Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify][SYSD] plan ENABLE+START cava.service Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify] controlButtonsLeds(OFF) unit=quadify-buttonsleds Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify][SYSD] plan DISABLE+STOP lircd.service Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify][SYSD] plan DISABLE+STOP ir_listener.service Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(plan): /usr/bin/sudo -n /bin/systemctl daemon-reload Oct 14 17:59:45 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(plan): /usr/bin/sudo -n /bin/systemctl disable --now lircd.service Oct 14 17:59:46 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(plan): /usr/bin/sudo -n /bin/systemctl disable --now ir_listener.service Oct 14 17:59:46 volumio2 volumio[1285]: info: [Quadify][SYSD] plan DISABLE+STOP quadify-buttonsleds.service Oct 14 17:59:46 volumio2 sudo[1822]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Oct 14 17:59:46 volumio2 sudo[1822]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:46 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(plan): /usr/bin/sudo -n /bin/systemctl disable --now quadify-buttonsleds.service Oct 14 17:59:46 volumio2 sudo[1824]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable --now lircd.service Oct 14 17:59:46 volumio2 sudo[1826]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable --now ir_listener.service Oct 14 17:59:46 volumio2 sudo[1826]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:46 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 17:59:46 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 17:59:46 volumio2 systemd[1]: Reloading. Oct 14 17:59:46 volumio2 sudo[1824]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:46 volumio2 sudo[1829]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable --now quadify-buttonsleds.service Oct 14 17:59:46 volumio2 sudo[1829]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:47 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 14 17:59:47 volumio2 volumio[1285]: info: Listing playlists Oct 14 17:59:47 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 14 17:59:47 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 14 17:59:47 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 14 17:59:47 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 14 17:59:49 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 27. Oct 14 17:59:49 volumio2 sudo[1822]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:50 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(plan): /usr/bin/sudo -n /bin/systemctl daemon-reload Oct 14 17:59:50 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(plan): /usr/bin/sudo -n /bin/systemctl enable --now cava.service Oct 14 17:59:50 volumio2 systemd[1]: Reloading. Oct 14 17:59:50 volumio2 sudo[1871]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable --now cava.service Oct 14 17:59:50 volumio2 sudo[1871]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:53 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 28. Oct 14 17:59:53 volumio2 systemd[1]: Reloading. Oct 14 17:59:53 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 14 17:59:55 volumio2 volumio[1285]: error: Plugin system_hardware quadify failed to complete 'onVolumioStart' in a timely fashion Oct 14 17:59:55 volumio2 volumio[1285]: info: Preparing to generate the ALSA configuration file Oct 14 17:59:56 volumio2 volumio[1285]: info: Asound.conf file unchanged, so no further update is needed Oct 14 17:59:56 volumio2 volumio[1285]: info: Output device has changed, restarting MPD Oct 14 17:59:56 volumio2 volumio[1285]: info: Output device has changed, restarting Shairport Sync Oct 14 17:59:56 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:56 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 17:59:56 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6. Oct 14 17:59:56 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 29. Oct 14 17:59:56 volumio2 systemd[1]: Reloading. Oct 14 17:59:56 volumio2 sudo[1914]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 17:59:56 volumio2 sudo[1914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:56 volumio2 sudo[1912]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 17:59:56 volumio2 sudo[1912]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:56 volumio2 sudo[1912]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:56 volumio2 volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 17:59:56 volumio2 volumio[1285]: info: ___________ START PLUGINS ___________ Oct 14 17:59:57 volumio2 volumio[1285]: info: ControllerMpd::onStart: Initializing MPD Oct 14 17:59:57 volumio2 volumio[1285]: info: Creating MPD Configuration file Oct 14 17:59:57 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 14 17:59:57 volumio2 volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 14 17:59:57 volumio2 volumio[1285]: info: [1791993597428] CoreMusicLibrary::Adding element Medienserver Oct 14 17:59:57 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 17:59:57 volumio2 python3[870]: 2026-10-14 17:59:57,496 - VolumioListener - INFO - [VolumioListener] Received pushBrowseSources event. Oct 14 17:59:57 volumio2 python3[870]: 2026-10-14 17:59:57,497 - network.service_listener - INFO - Requesting Volumio root music services from: http://localhost:3000/api/v1/browse?uri= Oct 14 17:59:57 volumio2 sudo[1922]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Oct 14 17:59:57 volumio2 sudo[1922]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:57 volumio2 volumio[1285]: info: UPNP Browser: Client initialized successfully Oct 14 17:59:57 volumio2 sudo[1934]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 14 17:59:57 volumio2 sudo[1934]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:57 volumio2 sudo[1934]: pam_unix(sudo:session): session closed for user root Oct 14 17:59:57 volumio2 sudo[1942]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 14 17:59:57 volumio2 sudo[1942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 17:59:57 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:57 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 17:59:58 volumio2 volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 17:59:58 volumio2 volumio[1285]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 14 17:59:58 volumio2 volumio[1285]: info: [1791993598235] CoreMusicLibrary::Adding element Last_100 Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 14 17:59:58 volumio2 volumio[1285]: info: [1791993598277] CoreMusicLibrary::Adding element Webradio Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 17:59:58 volumio2 volumio[1285]: info: Initializing BBC Radios Oct 14 17:59:58 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 17:59:59 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 17:59:59 volumio2 volumio[1285]: info: [ROTARYENCODER2] loadI18nStrings: /data/plugins/system_hardware/rotaryencoder2/i18n/strings_de.json Oct 14 17:59:59 volumio2 volumio[1285]: info: [ROTARYENCODER2] loadI18nStrings: loaded: Oct 14 17:59:59 volumio2 volumio[1285]: info: [ROTARYENCODER2] onStart: Config loaded: Oct 14 17:59:59 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayL Oct 14 17:59:59 volumio2 volumio[1285]: info: Volumio Calling Home Oct 14 17:59:59 volumio2 python3[870]: 2026-10-14 17:59:59,934 - VolumioListener - INFO - [VolumioListener] Received pushBrowseSources event. Oct 14 17:59:59 volumio2 python3[870]: 2026-10-14 17:59:59,935 - network.service_listener - INFO - Requesting Volumio root music services from: http://localhost:3000/api/v1/browse?uri= Oct 14 17:59:59 volumio2 python3[870]: 2026-10-14 17:59:59,988 - VolumioListener - INFO - [VolumioListener] Received pushBrowseSources event. Oct 14 18:00:00 volumio2 python3[870]: 2026-10-14 17:59:59,999 - network.service_listener - INFO - Requesting Volumio root music services from: http://localhost:3000/api/v1/browse?uri= Oct 14 18:00:00 volumio2 systemd[1]: Reloading. Oct 14 18:00:00 volumio2 sudo[1984]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Oct 14 18:00:00 volumio2 sudo[1984]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:00 volumio2 sudo[1984]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:03 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Oct 14 18:00:03 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 30. Oct 14 18:00:03 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:03 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:03 volumio2 (cava)[2012]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:03 volumio2 (cava)[2012]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:03 volumio2 sudo[1871]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:03 volumio2 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Oct 14 18:00:03 volumio2 systemd[1]: Starting mpd.service - Music Player Daemon... Oct 14 18:00:03 volumio2 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 18:00:03 volumio2 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 18:00:03 volumio2 systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 14 18:00:04 volumio2 sudo[1922]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:04 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:04 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:04 volumio2 upmpdcli[2015]: Could not open config: /tmp/upmpdcli.conf Oct 14 18:00:04 volumio2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 14 18:00:04 volumio2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 14 18:00:04 volumio2 sudo[1829]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:04 volumio2 sudo[2014]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 14 18:00:04 volumio2 sudo[2014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Oct 14 18:00:04 volumio2 sudo[2023]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 14 18:00:04 volumio2 sudo[2014]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:04 volumio2 sudo[1826]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:05 volumio2 volumio5-onboarding[2016]: time=2026-10-14T18:00:05.302+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 14 18:00:06 volumio2 systemd[1]: Reloading. Oct 14 18:00:08 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:08 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 14 18:00:08 volumio2 volumio[1285]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 14 18:00:08 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 14 18:00:08 volumio2 volumio[1285]: info: Received Get System Version Oct 14 18:00:08 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 18:00:08 volumio2 volumio[1285]: info: Received Get System Info Oct 14 18:00:08 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 18:00:08 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 18:00:09 volumio2 volumio[1285]: info: Discovery: Getting this device information Oct 14 18:00:09 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:09 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:09 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify] CMD OK: /bin/systemctl show -p LoadState -p FragmentPath quadify-buttonsleds.service Oct 14 18:00:10 volumio2 volumio[1285]: stdout: LoadState=loaded Oct 14 18:00:10 volumio2 volumio[1285]: FragmentPath=/etc/systemd/system/quadify-buttonsleds.service Oct 14 18:00:10 volumio2 volumio[1285]: stderr: Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][DETECT] quadify-buttonsleds.service load=loaded path=/etc/systemd/system/quadify-buttonsleds.service Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][DETECT] using unit=quadify-buttonsleds Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify] onStart ready Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayL returned: [] Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] installAllOverlays: 4 Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] installAllOverlays: 3 Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] installAllOverlays: 2 Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] installAllOverlays: 1 Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] installAllOverlays: 0 Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] installAllOverlays: end of recursion. Oct 14 18:00:10 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd Oct 14 18:00:10 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:10 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 31. Oct 14 18:00:10 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:10 volumio2 volumio[1285]: info: MPD Permissions set Oct 14 18:00:10 volumio2 volumio[1285]: info: MPD Permissions set Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(plan): /usr/bin/sudo -n /bin/systemctl disable --now ir_listener.service Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus ir_listener.service Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(plan): /usr/bin/sudo -n /bin/systemctl disable --now quadify-buttonsleds.service Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus quadify-buttonsleds.service Oct 14 18:00:10 volumio2 (cava)[2060]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:10 volumio2 (cava)[2060]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:10 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:10 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:10 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:10 volumio2 sudo[2061]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=17 pin_b=27 relative_axis=true steps-per-period=1 Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(plan): /usr/bin/sudo -n /bin/systemctl enable --now cava.service Oct 14 18:00:10 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus cava.service Oct 14 18:00:10 volumio2 sudo[2061]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:11 volumio2 volumio[1285]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 14 18:00:11 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus ir_listener.service Oct 14 18:00:11 volumio2 volumio[1285]: Result=success Oct 14 18:00:11 volumio2 volumio[1285]: ExecMainPID=0 Oct 14 18:00:11 volumio2 volumio[1285]: ExecMainStatus=0 Oct 14 18:00:11 volumio2 volumio[1285]: ActiveState=inactive Oct 14 18:00:11 volumio2 volumio[1285]: SubState=dead Oct 14 18:00:11 volumio2 volumio[1285]: FragmentPath=/etc/systemd/system/ir_listener.service Oct 14 18:00:11 volumio2 volumio[1285]: UnitFileState=disabled Oct 14 18:00:11 volumio2 volumio[1285]: info: [Quadify][SYSD] VERIFY ir_listener: active=inactive sub=dead enabled=disabled pid=0 status=0 result=success path=/etc/systemd/system/ir_listener.service Oct 14 18:00:11 volumio2 volumio[1285]: info: [Quadify][SYSD] ir_listener => active=inactive enabled=disabled Oct 14 18:00:11 volumio2 volumio[1285]: info: Volumio called home Oct 14 18:00:11 volumio2 systemd[1]: Reloading. Oct 14 18:00:11 volumio2 kernel: pinctrl-bcm2835 3f200000.gpio: pin gpio17 already requested by soc:shutdown_button@11; cannot claim for rotary@11 Oct 14 18:00:11 volumio2 kernel: pinctrl-bcm2835 3f200000.gpio: error -EINVAL: pin-17 (rotary@11) Oct 14 18:00:11 volumio2 kernel: pinctrl-bcm2835 3f200000.gpio: error -EINVAL: could not request pin 17 (gpio17) from group gpio17 on device pinctrl-bcm2835 Oct 14 18:00:11 volumio2 kernel: rotary-encoder rotary@11: Error applying setting, reverse things back Oct 14 18:00:11 volumio2 sudo[2061]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:11 volumio2 sudo[2070]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable quadify-leds-off.service Oct 14 18:00:11 volumio2 sudo[2070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:11 volumio2 sudo[2073]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable volumio-clean-poweroff.service Oct 14 18:00:11 volumio2 sudo[2073]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:13 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:14 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:15 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 32. Oct 14 18:00:15 volumio2 volumio5-onboarding[2016]: failed to create app: failed to initialize host: failed to create socket connection: could not connect to socket.io server: read tcp 127.0.0.1:45606->127.0.0.1:3000: i/o timeout Oct 14 18:00:15 volumio2 systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 14 18:00:15 volumio2 systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 14 18:00:15 volumio2 systemd[1]: Reloading. Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:15 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:16 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd executed: /usr/bin/sudo /usr/bin/dtoverlay rotary-encoder pin_a=17 pin_b=27 relative_axis=true steps-per-period=1 Oct 14 18:00:16 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus quadify-buttonsleds.service Oct 14 18:00:16 volumio2 volumio[1285]: Result=success Oct 14 18:00:16 volumio2 volumio[1285]: ExecMainPID=0 Oct 14 18:00:16 volumio2 volumio[1285]: ExecMainStatus=0 Oct 14 18:00:16 volumio2 volumio[1285]: ActiveState=inactive Oct 14 18:00:16 volumio2 volumio[1285]: SubState=dead Oct 14 18:00:16 volumio2 volumio[1285]: FragmentPath=/etc/systemd/system/quadify-buttonsleds.service Oct 14 18:00:16 volumio2 volumio[1285]: UnitFileState=disabled Oct 14 18:00:16 volumio2 volumio[1285]: info: [Quadify][SYSD] VERIFY quadify-buttonsleds: active=inactive sub=dead enabled=disabled pid=0 status=0 result=success path=/etc/systemd/system/quadify-buttonsleds.service Oct 14 18:00:16 volumio2 volumio[1285]: info: [Quadify][SYSD] quadify-buttonsleds => active=inactive enabled=disabled Oct 14 18:00:16 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus cava.service Oct 14 18:00:16 volumio2 volumio[1285]: Result=exit-code Oct 14 18:00:16 volumio2 volumio[1285]: ExecMainPID=2060 Oct 14 18:00:16 volumio2 volumio[1285]: ExecMainStatus=203 Oct 14 18:00:16 volumio2 volumio[1285]: ActiveState=activating Oct 14 18:00:16 volumio2 volumio[1285]: SubState=auto-restart Oct 14 18:00:16 volumio2 volumio[1285]: FragmentPath=/etc/systemd/system/cava.service Oct 14 18:00:16 volumio2 volumio[1285]: UnitFileState=enabled Oct 14 18:00:16 volumio2 volumio[1285]: info: [Quadify][SYSD] VERIFY cava: active=activating sub=auto-restart enabled=enabled pid=2060 status=203 result=exit-code path=/etc/systemd/system/cava.service Oct 14 18:00:16 volumio2 volumio[1285]: warn: [Quadify][SYSD] cava verify miss (have active=activating enabled=enabled, want active/enabled) → fallback Oct 14 18:00:16 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(fallback): /usr/bin/sudo -n /bin/systemctl start cava.service Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:16 volumio2 sudo[2132]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start cava.service Oct 14 18:00:16 volumio2 sudo[2132]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:16 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:17 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:17 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:17 volumio2 volumio[1285]: info: Starting Shairport Sync Oct 14 18:00:17 volumio2 python3[870]: 2026-10-14 18:00:17,168 - network.service_listener - ERROR - Failed to query Volumio API (root): HTTPConnectionPool(host='localhost', port=3000): Read timed out. (read timeout=6) Oct 14 18:00:17 volumio2 volumio[1285]: info: Starting Shairport Sync Oct 14 18:00:17 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:17 volumio2 volumio[1285]: info: Starting Shairport Sync Oct 14 18:00:17 volumio2 sudo[2135]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 18:00:17 volumio2 sudo[2135]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:17 volumio2 sudo[2137]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 18:00:17 volumio2 sudo[2137]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:17 volumio2 sudo[2144]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 14 18:00:17 volumio2 sudo[2144]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:17 volumio2 sudo[2144]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:17 volumio2 volumio[1285]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Oct 14 18:00:18 volumio2 sudo[2140]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 14 18:00:18 volumio2 sudo[2140]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:18 volumio2 sudo[2142]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 14 18:00:18 volumio2 volumio[1285]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Oct 14 18:00:18 volumio2 sudo[2142]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:18 volumio2 sudo[2142]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:19 volumio2 mpd[2024]: 2026-10-14T18:00:19 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 14 18:00:19 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:19 volumio2 python3[870]: 2026-10-14 18:00:19,631 - network.service_listener - ERROR - Failed to query Volumio API (root): HTTPConnectionPool(host='localhost', port=3000): Read timed out. (read timeout=6) Oct 14 18:00:19 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 33. Oct 14 18:00:19 volumio2 python3[870]: 2026-10-14 18:00:19,718 - network.service_listener - ERROR - Failed to query Volumio API (root): HTTPConnectionPool(host='localhost', port=3000): Read timed out. (read timeout=6) Oct 14 18:00:19 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 8. Oct 14 18:00:19 volumio2 sudo[2070]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:19 volumio2 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 1. Oct 14 18:00:19 volumio2 systemd[1]: Reloading. Oct 14 18:00:20 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 16 Oct 14 18:00:20 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:20 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:20 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:20 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:20 volumio2 volumio[1285]: info: [Quadify] CMD OK: /usr/bin/sudo -n /bin/systemctl enable quadify-leds-off.service Oct 14 18:00:20 volumio2 volumio[1285]: stdout: Oct 14 18:00:20 volumio2 volumio[1285]: stderr: Oct 14 18:00:20 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetVisibleSources Oct 14 18:00:20 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 14 18:00:20 volumio2 volumio[1285]: verbose: New Socket.io Connection to 192.168.10.138 from 192.168.10.25 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/154.0.0.0 Safari/537.36 Edg/154.0.0.0 Engine version: 3 Transport: polling Total Clients: 16 Oct 14 18:00:21 volumio2 volumio[1285]: info: [Quadify] UI populate: screen=vuscreen modern=undefined -> ui=vuscreen, rotate=180, spectrum=true Oct 14 18:00:21 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:21 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:21 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:21 volumio2 volumio[1285]: info: [ROTARYENCODER2] Socket connected to Volumio Oct 14 18:00:21 volumio2 volumio[1285]: error: [ROTARYENCODER2] dtoverlayAdd failed: Device /dev/input/by-path/platform-rotary@11-event did not appear after waiting for 5000ms. Oct 14 18:00:21 volumio2 volumio[1285]: error: [ROTARYENCODER2] installAllOverlays failed for rotary: {"pinA":17,"type":"rotary-encoder"} - Device /dev/input/by-path/platform-rotary@11-event did not appear after waiting for 5000ms. Oct 14 18:00:21 volumio2 volumio[1285]: info: [ROTARYENCODER2] getI18nString("TOAST_WRONG_PARAMETER"):Fehler in Einstellungen Oct 14 18:00:21 volumio2 volumio[1285]: info: [ROTARYENCODER2] getI18nString("TOAST_ERR_ADD_OVERLAY_FAILED"):Hinzufügen gescheitert für Overlay: Oct 14 18:00:21 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd Oct 14 18:00:22 volumio2 python3[870]: 2026-10-14 18:00:22,010 - VolumioListener - INFO - [VolumioListener] Received pushToastMessage event. Oct 14 18:00:22 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 14 18:00:22 volumio2 sudo[2184]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=22 active_low=true gpio_pull=up keycode=20 Oct 14 18:00:22 volumio2 sudo[2184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:22 volumio2 volumio[1285]: info: Listing playlists Oct 14 18:00:22 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:22 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:22 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 14 18:00:22 volumio2 kernel: input: button@16 as /devices/platform/button@16/input/input4 Oct 14 18:00:22 volumio2 volumio[1285]: info: Listing playlists Oct 14 18:00:22 volumio2 sudo[2184]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:23 volumio2 systemd[1]: Started mpd.service - Music Player Daemon. Oct 14 18:00:23 volumio2 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 2. Oct 14 18:00:23 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 34. Oct 14 18:00:23 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 9. Oct 14 18:00:23 volumio2 sudo[1942]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:23 volumio2 sudo[2073]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:23 volumio2 sudo[1914]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:23 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:23 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:23 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd executed: /usr/bin/sudo /usr/bin/dtoverlay gpio-key gpio=22 active_low=true gpio_pull=up keycode=20 Oct 14 18:00:23 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:23 volumio2 (cava)[2193]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:23 volumio2 (cava)[2193]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:23 volumio2 lircd[862]: lircd-0.10.1[862]: Notice: caught signal Oct 14 18:00:23 volumio2 lircd-0.10.1[862]: Notice: caught signal Oct 14 18:00:23 volumio2 systemd[1]: Stopping lircd.service - Flexible IR remote input/output application support... Oct 14 18:00:23 volumio2 sudo[2132]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:23 volumio2 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Oct 14 18:00:23 volumio2 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 18:00:23 volumio2 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 18:00:23 volumio2 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 14 18:00:23 volumio2 systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 14 18:00:23 volumio2 systemd[1]: lircd.service: Deactivated successfully. Oct 14 18:00:23 volumio2 systemd[1]: Stopped lircd.service - Flexible IR remote input/output application support. Oct 14 18:00:23 volumio2 systemd[1]: shairport-sync.service: Deactivated successfully. Oct 14 18:00:23 volumio2 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 18:00:23 volumio2 systemd[1]: shairport-sync.service: Consumed 2.329s CPU time. Oct 14 18:00:23 volumio2 upmpdcli[2194]: Could not open config: /tmp/upmpdcli.conf Oct 14 18:00:23 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:23 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:23 volumio2 volumio5-onboarding[2195]: time=2026-10-14T18:00:23.831+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 14 18:00:23 volumio2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 14 18:00:23 volumio2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 14 18:00:23 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:23 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:23 volumio2 volumio[1285]: info: [Quadify] CMD OK: /usr/bin/sudo -n /bin/systemctl enable volumio-clean-poweroff.service Oct 14 18:00:23 volumio2 volumio[1285]: stdout: Oct 14 18:00:23 volumio2 volumio[1285]: stderr: Oct 14 18:00:23 volumio2 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Oct 14 18:00:23 volumio2 sudo[2137]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:23 volumio2 sudo[2140]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:23 volumio2 sudo[2135]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:24 volumio2 python3[870]: 2026-10-14 18:00:24,021 - VolumioListener - INFO - [VolumioListener] Received pushToastMessage event. Oct 14 18:00:24 volumio2 sudo[1824]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:24 volumio2 volumio[1285]: info: [ROTARYENCODER2] attachEventEmitter: path: /dev/input/by-path/platform-button@16-event, type: gpio-key Oct 14 18:00:24 volumio2 volumio[1285]: info: [ROTARYENCODER2] addEventListeners for rotary: {"pinA":22,"type":"gpio-key"} Oct 14 18:00:24 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd Oct 14 18:00:24 volumio2 volumio[1285]: info: Shairport-Sync Started Oct 14 18:00:24 volumio2 sudo[2223]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=6 pin_b=13 relative_axis=true steps-per-period=1 Oct 14 18:00:24 volumio2 sudo[2223]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:24 volumio2 volumio[1285]: Error adding Membership: Error: addMembership EINVAL Oct 14 18:00:24 volumio2 volumio[1285]: info: Shairport-Sync Started Oct 14 18:00:24 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(plan): /usr/bin/sudo -n /bin/systemctl disable --now lircd.service Oct 14 18:00:24 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus lircd.service Oct 14 18:00:25 volumio2 volumio[1285]: info: Shairport-Sync Started Oct 14 18:00:25 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(fallback): /usr/bin/sudo -n /bin/systemctl start cava.service Oct 14 18:00:25 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus cava.service Oct 14 18:00:25 volumio2 kernel: rotary-encoder rotary@6: gray Oct 14 18:00:25 volumio2 kernel: input: rotary@6 as /devices/platform/rotary@6/input/input5 Oct 14 18:00:25 volumio2 sudo[2223]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:25 volumio2 wpa_supplicant[1209]: RRM: Ignoring radio measurement request: Not RRM network Oct 14 18:00:26 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 35. Oct 14 18:00:26 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:27 volumio2 (cava)[2235]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:27 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:27 volumio2 (cava)[2235]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:27 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:27 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:27 volumio2 volumio[1285]: error: MPD error: The expression evaluated to a falsy value: Oct 14 18:00:27 volumio2 volumio[1285]: assert.ok(self.idling) Oct 14 18:00:27 volumio2 volumio[1285]: error: The expression evaluated to a falsy value: Oct 14 18:00:27 volumio2 volumio[1285]: assert.ok(self.idling) Oct 14 18:00:27 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:27 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:27 volumio2 volumio[1285]: info: MPD running with PID2024 Oct 14 18:00:27 volumio2 volumio[1285]: ,establishing connection Oct 14 18:00:27 volumio2 volumio[1285]: error: updateQueue error: null Oct 14 18:00:27 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus cava.service Oct 14 18:00:27 volumio2 volumio[1285]: Result=exit-code Oct 14 18:00:27 volumio2 volumio[1285]: ExecMainPID=2193 Oct 14 18:00:27 volumio2 volumio[1285]: ExecMainStatus=203 Oct 14 18:00:27 volumio2 volumio[1285]: ActiveState=activating Oct 14 18:00:27 volumio2 volumio[1285]: SubState=auto-restart Oct 14 18:00:27 volumio2 volumio[1285]: FragmentPath=/etc/systemd/system/cava.service Oct 14 18:00:27 volumio2 volumio[1285]: UnitFileState=enabled Oct 14 18:00:27 volumio2 volumio[1285]: info: [Quadify][SYSD] VERIFY cava: active=activating sub=auto-restart enabled=enabled pid=2193 status=203 result=exit-code path=/etc/systemd/system/cava.service Oct 14 18:00:27 volumio2 volumio[1285]: info: [Quadify][SYSD] exec(logs): /usr/bin/sudo -n journalctl -u cava.service -n 40 -o cat Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(verify): /bin/systemctl show -p ActiveState -p SubState -p UnitFileState -p FragmentPath -p Result -p ExecMainPID -p ExecMainStatus lircd.service Oct 14 18:00:28 volumio2 volumio[1285]: Result=success Oct 14 18:00:28 volumio2 volumio[1285]: ExecMainPID=862 Oct 14 18:00:28 volumio2 volumio[1285]: ExecMainStatus=15 Oct 14 18:00:28 volumio2 volumio[1285]: ActiveState=inactive Oct 14 18:00:28 volumio2 volumio[1285]: SubState=dead Oct 14 18:00:28 volumio2 volumio[1285]: FragmentPath=/lib/systemd/system/lircd.service Oct 14 18:00:28 volumio2 volumio[1285]: UnitFileState=disabled Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][SYSD] VERIFY lircd: active=inactive sub=dead enabled=disabled pid=862 status=15 result=success path=/lib/systemd/system/lircd.service Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][SYSD] lircd => active=inactive enabled=disabled Oct 14 18:00:28 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd executed: /usr/bin/sudo /usr/bin/dtoverlay rotary-encoder pin_a=6 pin_b=13 relative_axis=true steps-per-period=1 Oct 14 18:00:28 volumio2 volumio[1285]: 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: 17 Oct 14 18:00:28 volumio2 volumio[1285]: info: [ROTARYENCODER2] attachEventEmitter: path: /dev/input/by-path/platform-rotary@6-event, type: rotary-encoder Oct 14 18:00:28 volumio2 volumio[1285]: info: [ROTARYENCODER2] addEventListeners for rotary: {"pinA":6,"type":"rotary-encoder"} Oct 14 18:00:28 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd Oct 14 18:00:28 volumio2 volumio[1285]: error: updateQueue error: null Oct 14 18:00:28 volumio2 volumio[1285]: 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: 17 Oct 14 18:00:28 volumio2 volumio[1285]: info: Received Get System Info Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 18:00:28 volumio2 volumio[1285]: info: Discovery: Getting this device information Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:28 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 18:00:28 volumio2 volumio5-onboarding[2195]: time=2026-10-14T18:00:28.168+02:00 level=INFO msg="system info for dff8e676165fe42ee54dc36682de08af" deviceName=Volumio2 deviceVariant=volumio deviceModel= softwareVersion=4.119 Oct 14 18:00:28 volumio2 volumio5-onboarding[2195]: time=2026-10-14T18:00:28.183+02:00 level=INFO msg="bootstrapping state" hasInternet=true Oct 14 18:00:28 volumio2 sudo[2237]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl -u cava.service -n 40 -o cat Oct 14 18:00:28 volumio2 sudo[2237]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:28 volumio2 volumio[1285]: info: Received Get System Info Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 18:00:28 volumio2 volumio[1285]: info: Discovery: Getting this device information Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:28 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 18:00:28 volumio2 volumio-remote-updater[672]: Test mode disabled Oct 14 18:00:28 volumio2 volumio-remote-updater[672]: Alpha mode disabled Oct 14 18:00:28 volumio2 volumio-remote-updater[672]: Alpha legacy test mode disabled Oct 14 18:00:28 volumio2 sudo[2237]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:28 volumio2 volumio[1285]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Oct 14 18:00:28 volumio2 sudo[2243]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=26 active_low=true gpio_pull=up keycode=20 Oct 14 18:00:28 volumio2 sudo[2243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 14 18:00:28 volumio2 kernel: input: button@1a as /devices/platform/button@1a/input/input6 Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][SYSD] cmd OK(logs): /usr/bin/sudo -n journalctl -u cava.service -n 40 -o cat Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 26. Oct 14 18:00:28 volumio2 volumio[1285]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 27. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 28. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 29. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 30. Oct 14 18:00:28 volumio2 volumio[1285]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 31. Oct 14 18:00:28 volumio2 volumio[1285]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 32. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 33. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 34. Oct 14 18:00:28 volumio2 volumio[1285]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Scheduled restart job, restart counter is at 35. Oct 14 18:00:28 volumio2 volumio[1285]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:28 volumio2 volumio[1285]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][SYSD] cava => active=activating enabled=enabled Oct 14 18:00:28 volumio2 volumio5-onboarding[2195]: time=2026-10-14T18:00:28.696+02:00 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" Oct 14 18:00:28 volumio2 volumio5-onboarding[2195]: time=2026-10-14T18:00:28.698+02:00 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" Oct 14 18:00:28 volumio2 volumio5-onboarding[2195]: time=2026-10-14T18:00:28.698+02:00 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" Oct 14 18:00:28 volumio2 sudo[2243]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][RESULT] cava: ok Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][RESULT] quadify-buttonsleds: active=inactive enabled=disabled Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][RESULT] lircd: active=inactive enabled=disabled Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][RESULT] ir_listener: active=inactive enabled=disabled Oct 14 18:00:28 volumio2 volumio[1285]: info: [Quadify][RESULT] safe-shutdown: ok Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 14 18:00:28 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayAdd executed: /usr/bin/sudo /usr/bin/dtoverlay gpio-key gpio=26 active_low=true gpio_pull=up keycode=20 Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 14 18:00:28 volumio2 volumio[1285]: info: Received Get System Info Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 18:00:28 volumio2 volumio[1285]: info: Discovery: Getting this device information Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::volumioGetState Oct 14 18:00:28 volumio2 volumio[1285]: info: CorePlayQueue::getTrack 0 Oct 14 18:00:28 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 18:00:29 volumio2 volumio[1285]: info: [ROTARYENCODER2] attachEventEmitter: path: /dev/input/by-path/platform-button@1a-event, type: gpio-key Oct 14 18:00:29 volumio2 volumio[1285]: info: [ROTARYENCODER2] addEventListeners for rotary: {"pinA":26,"type":"gpio-key"} Oct 14 18:00:29 volumio2 volumio[1285]: info: [ROTARYENCODER2] dtoverlayL Oct 14 18:00:29 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 18:00:29 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 14 18:00:29 volumio2 volumio[1285]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 14 18:00:29 volumio2 sudo[2259]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Oct 14 18:00:29 volumio2 sudo[2259]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 18:00:29 volumio2 volumio[1285]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 18:00:29 volumio2 sudo[2259]: pam_unix(sudo:session): session closed for user root Oct 14 18:00:29 volumio2 volumio[1285]: Error: Unable to resolve or reject the same promise twice Oct 14 18:00:29 volumio2 volumio[1285]: at Promise.resolve (/data/plugins/system_hardware/rotaryencoder2/node_modules/kew/kew.js:140:43) Oct 14 18:00:29 volumio2 volumio[1285]: at /data/plugins/system_hardware/rotaryencoder2/index.js:1017:23 Oct 14 18:00:29 volumio2 volumio[1285]: at FSReqCallback.oncomplete (node:fs:190:23) Oct 14 18:00:29 volumio2 volumio[1285]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 18:00:30 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 36. Oct 14 18:00:30 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:30 volumio2 (cava)[2275]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:30 volumio2 (cava)[2275]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:30 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:30 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:30 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:33 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 37. Oct 14 18:00:33 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:33 volumio2 (cava)[2291]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:33 volumio2 (cava)[2291]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:33 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:33 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:33 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:36 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 38. Oct 14 18:00:36 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:36 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:36 volumio2 (cava)[2292]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:36 volumio2 (cava)[2292]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:36 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:36 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:38 volumio2 volumio5-onboarding[2195]: failed to configure discovery: failed to check if setup wizard should be shown: could not get wizard status: context deadline exceeded Oct 14 18:00:38 volumio2 systemd[1]: volumio5-onboarding.service: Main process exited, code=exited, status=1/FAILURE Oct 14 18:00:38 volumio2 systemd[1]: volumio5-onboarding.service: Failed with result 'exit-code'. Oct 14 18:00:38 volumio2 systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10. Oct 14 18:00:38 volumio2 systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 18:00:39 volumio2 systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Oct 14 18:00:39 volumio2 upmpdcli[2293]: Could not open config: /tmp/upmpdcli.conf Oct 14 18:00:39 volumio2 systemd[1]: volumio5-onboarding.service: Scheduled restart job, restart counter is at 3. Oct 14 18:00:39 volumio2 systemd[1]: Stopped volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 14 18:00:39 volumio2 systemd[1]: Started volumio5-onboarding.service - Volumio5 Onboarding Server. Oct 14 18:00:39 volumio2 systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Oct 14 18:00:39 volumio2 systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Oct 14 18:00:39 volumio2 volumio5-onboarding[2294]: time=2026-10-14T18:00:39.178+02:00 level=INFO msg="running volumio5-device-gateway" version=6370e0a8+CHANGES buildDate=2026-03-06T16:29:42Z Oct 14 18:00:39 volumio2 systemd[1]: cava.service: Scheduled restart job, restart counter is at 39. Oct 14 18:00:39 volumio2 systemd[1]: Stopped cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:39 volumio2 (cava)[2303]: cava.service: Failed to locate executable /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:39 volumio2 (cava)[2303]: cava.service: Failed at step EXEC spawning /data/plugins/system_hardware/quadify/cava/bin/cava: No such file or directory Oct 14 18:00:39 volumio2 systemd[1]: Started cava.service - CAVA - Console-based Audio Visualizer (Quadify Plugin). Oct 14 18:00:39 volumio2 systemd[1]: cava.service: Main process exited, code=exited, status=203/EXEC Oct 14 18:00:39 volumio2 systemd[1]: cava.service: Failed with result 'exit-code'. Oct 14 18:00:40 volumio2 sudo[2306]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 17:59' Oct 14 18:00:40 volumio2 sudo[2306]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"