Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=trace msg="received accesspoint ping" Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=error msg="did not receive last pong ack from accesspoint, 120s passed" Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=trace msg="sent dealer ping" Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=error msg="failed receiving packet" error="failed reading packet header: read tcp 192.168.8.126:47640->104.154.127.247:4070: use of closed network connection" Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=trace msg="received dealer pong" Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=debug msg="connected to ap-gue1.spotify.com:443" Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=debug msg="completed keyexchange" Jan 13 23:19:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:02+01:00" level=debug msg="completed challenge" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=info msg="authenticated AP" username="31************************la" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=debug msg="re-established accesspoint connection" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=trace msg="received accesspoint ping" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481" Jan 13 23:19:03 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:03+01:00" level=trace msg="received accesspoint pong ack" Jan 13 23:19:06 volumio-audio volumio[1122]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/touch_display/volumio/bookworm/armhf Jan 13 23:19:08 volumio-audio volumio[1122]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/touch_display/volumio/bookworm/armhf Jan 13 23:19:08 volumio-audio volumio[1122]: info: Folder /tmp/plugins removed Jan 13 23:19:08 volumio-audio volumio[1122]: info: Check plugin dependencies Jan 13 23:19:08 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 23:19:08 volumio-audio volumio[1122]: info: Checking if plugin already exists Jan 13 23:19:08 volumio-audio volumio[1122]: info: Rename folder Jan 13 23:19:09 volumio-audio volumio[1122]: info: Folder /tmp/downloaded_plugin.zip removed Jan 13 23:19:09 volumio-audio volumio[1122]: info: Move to category Jan 13 23:19:09 volumio-audio volumio[1122]: info: Checking if install.sh is present Jan 13 23:19:09 volumio-audio volumio[1122]: info: Executing install.sh Jan 13 23:19:09 volumio-audio sudo[2630]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/touch_display/install.sh Jan 13 23:19:09 volumio-audio sudo[2630]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:19:09 volumio-audio volumio[1122]: info: Re-synchronizing package index files from their sources Jan 13 23:19:09 volumio-audio volumio[1122]: info: Hit:1 http://archive.raspberrypi.com/debian bookworm InRelease Jan 13 23:19:09 volumio-audio volumio[1122]: info: Hit:2 https://deb.nodesource.com/node_20.x nodistro InRelease Jan 13 23:19:10 volumio-audio volumio[1122]: info: Hit:3 http://raspbian.raspberrypi.com/raspbian bookworm InRelease Jan 13 23:19:14 volumio-audio volumio[1122]: info: Reading package lists... Jan 13 23:19:16 volumio-audio volumio[1122]: info: Running apt-get -y install failed Jan 13 23:19:16 volumio-audio volumio[1122]: info: Plugin failed to install! Jan 13 23:19:16 volumio-audio volumio[1122]: info: Cleaning up... Jan 13 23:19:32 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:32+01:00" level=trace msg="sent dealer ping" Jan 13 23:19:32 volumio-audio go-librespot[1518]: time="2026-01-13T23:19:32+01:00" level=trace msg="received dealer pong" Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing dependencies Jan 13 23:19:34 volumio-audio volumio[1122]: info: Reading package lists... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Building dependency tree... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Reading state information... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Package 'openbox' is not installed, so not removed Jan 13 23:19:34 volumio-audio volumio[1122]: info: The following packages will be REMOVED: Jan 13 23:19:34 volumio-audio volumio[1122]: info: libabsl20220623* libavif15* libc-dev-bin* libc-devtools* libde265-0* Jan 13 23:19:34 volumio-audio volumio[1122]: info: libgav1-1* libgd3* libheif1* libyuv0* linux-libc-dev* Jan 13 23:19:34 volumio-audio volumio[1122]: info: 0 upgraded, 0 newly installed, 10 to remove and 37 not upgraded. Jan 13 23:19:34 volumio-audio volumio[1122]: info: 12 not fully installed or removed. Jan 13 23:19:34 volumio-audio volumio[1122]: info: After this operation, 4977 kB disk space will be freed. Jan 13 23:19:34 volumio-audio volumio[1122]: [620B blob data] Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libc-devtools (2.36-9+rpt2+deb12u13) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libgd3:armhf (2.3.3-9) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libavif15:armhf (0.11.1-1+deb12u1) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libgav1-1:armhf (0.18.0-1+rpi1+b1) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libabsl20220623:armhf (20220623.1-1+rpi1+deb12u2) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libc-dev-bin (2.36-9+rpt2+deb12u13) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libheif1:armhf (1.15.1-1+deb12u1) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libde265-0:armhf (1.0.11-1+rpi1) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing libyuv0:armhf (0.0~git20230123.b2528b0-1) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: dpkg: error processing package linux-libc-dev (--remove): Jan 13 23:19:34 volumio-audio volumio[1122]: info: package is in a very bad inconsistent state; you should Jan 13 23:19:34 volumio-audio volumio[1122]: info: reinstall it before attempting a removal Jan 13 23:19:34 volumio-audio volumio[1122]: info: dpkg: too many errors, stopping Jan 13 23:19:34 volumio-audio volumio[1122]: info: Errors were encountered while processing: Jan 13 23:19:34 volumio-audio volumio[1122]: info: linux-libc-dev Jan 13 23:19:34 volumio-audio volumio[1122]: info: Processing was halted because there were too many errors. Jan 13 23:19:34 volumio-audio volumio[1122]: info: Reading package lists... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Building dependency tree... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Reading state information... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Package 'xinit' is not installed, so not removed Jan 13 23:19:34 volumio-audio volumio[1122]: info: The following additional packages will be installed: Jan 13 23:19:34 volumio-audio volumio[1122]: info: linux-libc-dev Jan 13 23:19:34 volumio-audio volumio[1122]: info: The following packages will be upgraded: Jan 13 23:19:34 volumio-audio volumio[1122]: info: linux-libc-dev Jan 13 23:19:34 volumio-audio volumio[1122]: info: 1 upgraded, 0 newly installed, 0 to remove and 37 not upgraded. Jan 13 23:19:34 volumio-audio volumio[1122]: info: 3 not fully installed or removed. Jan 13 23:19:34 volumio-audio volumio[1122]: info: Need to get 0 B/2315 kB of archives. Jan 13 23:19:34 volumio-audio volumio[1122]: info: After this operation, 8368 kB of additional disk space will be used. Jan 13 23:19:34 volumio-audio volumio[1122]: [620B blob data] Jan 13 23:19:34 volumio-audio volumio[1122]: info: Preparing to unpack .../linux-libc-dev_1%3a6.12.47-1+rpt1~bookworm_all.deb ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Unpacking linux-libc-dev (1:6.12.47-1+rpt1~bookworm) over (1:6.12.47-1+rpt1~bookworm) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Setting up manpages (6.03-2) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Setting up fonts-freefont-ttf (20120503-10) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Setting up linux-libc-dev (1:6.12.47-1+rpt1~bookworm) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Processing triggers for fontconfig (2.14.1-4) ... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Reading package lists... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Building dependency tree... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Reading state information... Jan 13 23:19:34 volumio-audio volumio[1122]: info: Package 'x11-utils' is not installed, so not removed Jan 13 23:19:34 volumio-audio volumio[1122]: info: 0 upgraded, 0 newly installed, 0 to remove and 37 not upgraded. Jan 13 23:19:34 volumio-audio sudo[2630]: pam_unix(sudo:session): session closed for user root Jan 13 23:19:34 volumio-audio volumio[1122]: info: Deleting /opt/volumiokiosk.sh Jan 13 23:19:34 volumio-audio volumio[1122]: info: Deleting /data/volumiokiosk Jan 13 23:19:34 volumio-audio volumio[1122]: info: Deleting /data/volumiokioskextensions Jan 13 23:19:34 volumio-audio volumio[1122]: info: Deleting /lib/systemd/system/volumio-kiosk.service Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing DRI permission udev rules Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing volumio user from video and render groups Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing user volumio from group video Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing user volumio from group render Jan 13 23:19:34 volumio-audio volumio[1122]: info: Removing Mesa shader cache directory Jan 13 23:19:34 volumio-audio volumio[1122]: info: Done Jan 13 23:19:35 volumio-audio volumio[1122]: info: Install script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/user_interface/touch_display/install.sh > /tmp/installog Jan 13 23:19:35 volumio-audio volumio[1122]: [sudo] password for volumio: E: dpkg was interrupted, you must manually run 'sudo dpkg --configure -a' to correct the problem. Jan 13 23:19:35 volumio-audio volumio[1122]: E: dpkg was interrupted, you must manually run 'sudo dpkg --configure -a' to correct the problem. Jan 13 23:19:35 volumio-audio volumio[1122]: E: dpkg was interrupted, you must manually run 'sudo dpkg --configure -a' to correct the problem. Jan 13 23:19:35 volumio-audio volumio[1122]: E: dpkg was interrupted, you must manually run 'sudo dpkg --configure -a' to correct the problem. Jan 13 23:19:35 volumio-audio volumio[1122]: E: dpkg was interrupted, you must manually run 'sudo dpkg --configure -a' to correct the problem. Jan 13 23:19:35 volumio-audio volumio[1122]: E: dpkg was interrupted, you must manually run 'sudo dpkg --configure -a' to correct the problem. Jan 13 23:19:35 volumio-audio volumio[1122]: E: dpkg was interrupted, you must manually run 'sudo dpkg --configure -a' to correct the problem. Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove rpi-chromium-mods which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove chromium-browser which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove chromium which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove chromium-common which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove chromium-l10n which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove chromium-codecs-ffmpeg-extra which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove libwidevinecdm0 which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: dpkg: warning: ignoring request to remove zenoty which isn't installed Jan 13 23:19:35 volumio-audio volumio[1122]: rm: cannot remove '/usr/bin/chromium-browser': No such file or directory Jan 13 23:19:35 volumio-audio volumio[1122]: E: Sub-process /usr/bin/dpkg returned an error code (1) Jan 13 23:19:35 volumio-audio volumio[1122]: debconf: delaying package configuration, since apt-utils is not installed Jan 13 23:19:35 volumio-audio volumio[1122]: rm: cannot remove '/opt/volumiokiosk.sh': No such file or directory Jan 13 23:19:35 volumio-audio volumio[1122]: rm: cannot remove '/lib/systemd/system/volumio-kiosk.service': No such file or directory Jan 13 23:19:35 volumio-audio volumio[1122]: info: An error occurred installing the plugin. Rolling back config Jan 13 23:19:35 volumio-audio volumio[1122]: info: Plugin folders cleanup Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning into folder /volumio/app/plugins/ Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category audio_interface Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category miscellanea Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category music_service Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category plugins.json Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category system_controller Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category user_interface Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning into folder /data/plugins/ Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category music_service Jan 13 23:19:35 volumio-audio volumio[1122]: info: Scanning category user_interface Jan 13 23:19:35 volumio-audio volumio[1122]: info: Plugin folders cleanup completed Jan 13 23:19:35 volumio-audio volumio[1122]: info: Error: Error Jan 13 23:19:35 volumio-audio volumio[1122]: info: Removing plugin directory /data/plugins/user_interface/touch_display Jan 13 23:19:35 volumio-audio volumio[1122]: info: Folder /tmp/plugins removed Jan 13 23:19:35 volumio-audio volumio[1122]: info: Folder /tmp/downloaded_plugin.zip removed Jan 13 23:19:35 volumio-audio volumio[1122]: info: Folder /data/temp removed Jan 13 23:19:35 volumio-audio volumio[1122]: Plugin install end detected on script Jan 13 23:19:58 volumio-audio sudo[3032]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 23:19:58 volumio-audio sudo[3032]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:19:58 volumio-audio sudo[3032]: pam_unix(sudo:session): session closed for user root Jan 13 23:19:58 volumio-audio sudo[3034]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 23:19:58 volumio-audio sudo[3034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:19:58 volumio-audio sudo[3034]: pam_unix(sudo:session): session closed for user root Jan 13 23:19:59 volumio-audio volumio[1122]: verbose: New Socket.io Connection to 192.168.8.126 from 192.168.8.124 UA: Mozilla/5.0 (Linux; Android 14; SM-M135F Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jan 13 23:20:00 volumio-audio sudo[3041]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 13 23:20:00 volumio-audio sudo[3041]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:00 volumio-audio sudo[3041]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:00 volumio-audio sudo[3043]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 13 23:20:00 volumio-audio sudo[3043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:00 volumio-audio sudo[3043]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:00 volumio-audio volumio[1122]: verbose: New Socket.io Connection to 192.168.8.126 from 192.168.8.124 UA: Mozilla/5.0 (Linux; Android 14; SM-M135F Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.192 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jan 13 23:20:00 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::volumioGetState Jan 13 23:20:01 volumio-audio volumio[1122]: info: CorePlayQueue::getTrack 2 Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 13 23:20:01 volumio-audio volumio[1122]: info: Received Get System Info Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 23:20:01 volumio-audio volumio[1122]: info: Discovery: Getting this device information Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::volumioGetState Jan 13 23:20:01 volumio-audio volumio[1122]: info: CorePlayQueue::getTrack 2 Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::volumioGetState Jan 13 23:20:01 volumio-audio volumio[1122]: info: CorePlayQueue::getTrack 2 Jan 13 23:20:01 volumio-audio volumio[1122]: info: Listing playlists Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 13 23:20:01 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 13 23:20:02 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 13 23:20:02 volumio-audio volumio[1122]: info: Received Get System Info Jan 13 23:20:02 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 23:20:02 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 23:20:02 volumio-audio volumio[1122]: info: Discovery: Getting this device information Jan 13 23:20:02 volumio-audio volumio[1122]: info: CoreCommandRouter::volumioGetState Jan 13 23:20:02 volumio-audio volumio[1122]: info: CorePlayQueue::getTrack 2 Jan 13 23:20:02 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 23:20:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:20:02+01:00" level=trace msg="sent dealer ping" Jan 13 23:20:02 volumio-audio go-librespot[1518]: time="2026-01-13T23:20:02+01:00" level=trace msg="received dealer pong" Jan 13 23:20:02 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jan 13 23:20:03 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 13 23:20:03 volumio-audio volumio[1122]: info: Received Get System Info Jan 13 23:20:03 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 23:20:03 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 23:20:03 volumio-audio volumio[1122]: info: Discovery: Getting this device information Jan 13 23:20:03 volumio-audio volumio[1122]: info: CoreCommandRouter::volumioGetState Jan 13 23:20:03 volumio-audio volumio[1122]: info: CorePlayQueue::getTrack 2 Jan 13 23:20:03 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 23:20:04 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 13 23:20:04 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 13 23:20:10 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jan 13 23:20:14 volumio-audio volumio[1122]: info: Starting Uninstall of plugin user_interface - peppymeterbasic Jan 13 23:20:14 volumio-audio volumio[1122]: info: Uninstalling plugin peppymeterbasic Jan 13 23:20:14 volumio-audio volumio[1122]: info: Stopping peppymeterbasic service Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreStateMachine::stop Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 23:20:14 volumio-audio volumio[1122]: info: Disabling plugin peppymeterbasic Jan 13 23:20:14 volumio-audio volumio[1122]: info: Preparing to generate the ALSA configuration file Jan 13 23:20:14 volumio-audio sudo[3067]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 23:20:14 volumio-audio sudo[3067]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:14 volumio-audio volumio[1122]: info: Asound.conf file written Jan 13 23:20:14 volumio-audio sudo[3067]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:14 volumio-audio sudo[3072]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 13 23:20:14 volumio-audio sudo[3072]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:14 volumio-audio sudo[3072]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:14 volumio-audio volumio[1122]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Jan 13 23:20:14 volumio-audio volumio[1122]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Jan 13 23:20:14 volumio-audio volumio[1122]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Jan 13 23:20:14 volumio-audio volumio[1122]: No state is present for card Loopback Jan 13 23:20:14 volumio-audio volumio[1122]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Jan 13 23:20:14 volumio-audio volumio[1122]: Found hardware: "Loopback" "Loopback Mixer" "" "" "" Jan 13 23:20:14 volumio-audio volumio[1122]: Hardware is initialized using a generic method Jan 13 23:20:14 volumio-audio volumio[1122]: No state is present for card Loopback Jan 13 23:20:14 volumio-audio volumio[1122]: info: Output device has changed, restarting MPD Jan 13 23:20:14 volumio-audio volumio[1122]: info: Output device has changed, restarting Shairport Sync Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 23:20:14 volumio-audio sudo[3078]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 13 23:20:14 volumio-audio sudo[3078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:14 volumio-audio sudo[3078]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:14 volumio-audio volumio[1122]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 13 23:20:14 volumio-audio sudo[3080]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 13 23:20:14 volumio-audio sudo[3080]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:14 volumio-audio volumio[1122]: info: Checking if uninstall.sh is present Jan 13 23:20:14 volumio-audio volumio[1122]: info: MPD Permissions set Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio systemd[1]: Stopping mpd.service - Music Player Daemon... Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 13 23:20:14 volumio-audio volumio[1122]: info: Executing uninstall.sh Jan 13 23:20:14 volumio-audio volumio[1122]: info: Starting Shairport Sync Jan 13 23:20:14 volumio-audio systemd[1]: mpd.service: Deactivated successfully. Jan 13 23:20:14 volumio-audio systemd[1]: Stopped mpd.service - Music Player Daemon. Jan 13 23:20:14 volumio-audio systemd[1]: mpd.service: Consumed 1.789s CPU time. Jan 13 23:20:14 volumio-audio systemd[1]: mpd.socket: Deactivated successfully. Jan 13 23:20:14 volumio-audio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jan 13 23:20:14 volumio-audio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jan 13 23:20:14 volumio-audio sudo[3099]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/peppymeterbasic/uninstall.sh Jan 13 23:20:14 volumio-audio sudo[3099]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:14 volumio-audio sudo[3101]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 13 23:20:14 volumio-audio sudo[3101]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:14 volumio-audio sudo[3104]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm -Rf /data/plugins/user_interface/peppymeterbasic/BasicPeppyMeter/__pycache__ Jan 13 23:20:14 volumio-audio sudo[3104]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 13 23:20:14 volumio-audio sudo[3104]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:14 volumio-audio sudo[3108]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm /etc/systemd/system/peppymeterbasic.service Jan 13 23:20:14 volumio-audio sudo[3108]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 13 23:20:14 volumio-audio sudo[3108]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:14 volumio-audio sudo[3099]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:14 volumio-audio volumio[1122]: info: Uninstall script completed Jan 13 23:20:14 volumio-audio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jan 13 23:20:14 volumio-audio volumio[1122]: info: Removing plugin peppymeterbasic from configuration Jan 13 23:20:14 volumio-audio systemd[1]: Starting mpd.service - Music Player Daemon... Jan 13 23:20:14 volumio-audio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jan 13 23:20:14 volumio-audio systemd[1]: shairport-sync.service: Deactivated successfully. Jan 13 23:20:14 volumio-audio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 13 23:20:14 volumio-audio systemd[1]: shairport-sync.service: Consumed 1.731s CPU time. Jan 13 23:20:14 volumio-audio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jan 13 23:20:14 volumio-audio sudo[3101]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:14 volumio-audio volumio[1122]: info: Successfully removed peppymeterbasic configuration files Jan 13 23:20:14 volumio-audio volumio[1122]: info: Plugin folders cleanup Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning into folder /volumio/app/plugins/ Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category audio_interface Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category miscellanea Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category music_service Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category plugins.json Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category system_controller Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category user_interface Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning into folder /data/plugins/ Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category music_service Jan 13 23:20:14 volumio-audio volumio[1122]: info: Scanning category user_interface Jan 13 23:20:14 volumio-audio volumio[1122]: info: Cleaning folder for peppymeterbasic Jan 13 23:20:14 volumio-audio sudo[3110]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 13 23:20:14 volumio-audio sudo[3110]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jan 13 23:20:14 volumio-audio sudo[3110]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:15 volumio-audio volumio[1122]: info: Plugin folders cleanup completed Jan 13 23:20:15 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 13 23:20:15 volumio-audio volumio[1122]: info: [{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"4.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.4","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.15","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"1.0.3","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Jan 13 23:20:15 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jan 13 23:20:15 volumio-audio volumio[1122]: info: Shairport-Sync Started Jan 13 23:20:16 volumio-audio mpd[3137]: 2026-01-13T23:20:16 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 13 23:20:16 volumio-audio systemd[1]: Started mpd.service - Music Player Daemon. Jan 13 23:20:16 volumio-audio sudo[3080]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:16 volumio-audio volumio[1122]: error: updateQueue error: null Jan 13 23:20:18 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 13 23:20:18 volumio-audio volumio[1122]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 13 23:20:18 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 13 23:20:18 volumio-audio volumio[1122]: info: Received Get System Version Jan 13 23:20:18 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 13 23:20:18 volumio-audio volumio[1122]: info: Received Get System Info Jan 13 23:20:18 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 13 23:20:18 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 13 23:20:18 volumio-audio volumio[1122]: info: Discovery: Getting this device information Jan 13 23:20:18 volumio-audio volumio[1122]: info: CoreCommandRouter::volumioGetState Jan 13 23:20:18 volumio-audio volumio[1122]: info: CorePlayQueue::getTrack 2 Jan 13 23:20:18 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 13 23:20:19 volumio-audio sudo[3160]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Jan 13 23:20:19 volumio-audio sudo[3160]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 23:20:19 volumio-audio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Jan 13 23:20:19 volumio-audio systemd[1]: mpd_monitor.service: Deactivated successfully. Jan 13 23:20:19 volumio-audio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Jan 13 23:20:19 volumio-audio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Jan 13 23:20:19 volumio-audio sudo[3160]: pam_unix(sudo:session): session closed for user root Jan 13 23:20:19 volumio-audio volumio[1122]: info: Successfully started MPD Monitor Jan 13 23:20:19 volumio-audio mpd_monitor.sh[3162]: MPD Monitor Service: Starting MPD Monitor Service Jan 13 23:20:28 volumio-audio volumio[1122]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 13 23:20:32 volumio-audio volumio[1122]: info: CALLMETHOD: user_interface Systeminfo runBench undefined Jan 13 23:20:32 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: Systeminfo , runBench Jan 13 23:20:32 volumio-audio go-librespot[1518]: time="2026-01-13T23:20:32+01:00" level=trace msg="sent dealer ping" Jan 13 23:20:32 volumio-audio go-librespot[1518]: time="2026-01-13T23:20:32+01:00" level=trace msg="received dealer pong" Jan 13 23:20:33 volumio-audio volumio[1122]: info: CALLMETHOD: user_interface Systeminfo runSysbench undefined Jan 13 23:20:33 volumio-audio volumio[1122]: info: CoreCommandRouter::executeOnPlugin: Systeminfo , runSysbench Jan 13 23:20:33 volumio-audio volumio[1122]: info: Starting full sysbench sequence... Jan 13 23:20:33 volumio-audio volumio[1122]: error: Sysbench failed: Command failed: sysbench cpu --threads=$(nproc) --time=10 run Jan 13 23:20:33 volumio-audio volumio[1122]: /bin/sh: 1: sysbench: not found Jan 13 23:20:33 volumio-audio volumio[1122]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 23:20:33 volumio-audio volumio[1122]: Error: Command failed: sysbench cpu --threads=$(nproc) --time=10 run Jan 13 23:20:33 volumio-audio volumio[1122]: /bin/sh: 1: sysbench: not found Jan 13 23:20:33 volumio-audio volumio[1122]: at ChildProcess.exithandler (node:child_process:421:12) Jan 13 23:20:33 volumio-audio volumio[1122]: at ChildProcess.emit (node:events:514:28) Jan 13 23:20:33 volumio-audio volumio[1122]: at maybeClose (node:internal/child_process:1105:16) Jan 13 23:20:33 volumio-audio volumio[1122]: at Socket. (node:internal/child_process:457:11) Jan 13 23:20:33 volumio-audio volumio[1122]: at Socket.emit (node:events:514:28) Jan 13 23:20:33 volumio-audio volumio[1122]: at Pipe. (node:net:337:12) { Jan 13 23:20:33 volumio-audio volumio[1122]: code: 127, Jan 13 23:20:33 volumio-audio volumio[1122]: killed: false, Jan 13 23:20:33 volumio-audio volumio[1122]: signal: null, Jan 13 23:20:33 volumio-audio volumio[1122]: cmd: 'sysbench cpu --threads=$(nproc) --time=10 run' Jan 13 23:20:33 volumio-audio volumio[1122]: } Jan 13 23:20:33 volumio-audio volumio[1122]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 23:20:34 volumio-audio sudo[3210]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-13 23:19' Jan 13 23:20:34 volumio-audio sudo[3210]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"