Dec 26 16:03:13 volupi52 volumio[1485]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/peppymeterbasic/volumio/bookworm/armhf Dec 26 16:03:15 volupi52 volumio[1485]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/peppymeterbasic/volumio/bookworm/armhf Dec 26 16:03:15 volupi52 volumio[1485]: info: Folder /tmp/plugins removed Dec 26 16:03:15 volupi52 volumio[1485]: info: Check plugin dependencies Dec 26 16:03:15 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 26 16:03:15 volupi52 volumio[1485]: info: Checking if plugin already exists Dec 26 16:03:15 volupi52 volumio[1485]: info: Rename folder Dec 26 16:03:15 volupi52 volumio[1485]: info: Folder /tmp/downloaded_plugin.zip removed Dec 26 16:03:15 volupi52 volumio[1485]: info: Move to category Dec 26 16:03:15 volupi52 volumio[1485]: info: Checking if install.sh is present Dec 26 16:03:15 volupi52 volumio[1485]: info: Executing install.sh Dec 26 16:03:15 volupi52 sudo[9964]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/peppymeterbasic/install.sh Dec 26 16:03:15 volupi52 sudo[9964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:15 volupi52 volumio[1485]: info: Installing peppyalsa plugin dependencies Dec 26 16:03:15 volupi52 sudo[9968]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update Dec 26 16:03:15 volupi52 sudo[9968]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:15 volupi52 volumio[1485]: info: Hit:1 http://archive.raspberrypi.com/debian bookworm InRelease Dec 26 16:03:15 volupi52 volumio[1485]: info: Hit:2 https://deb.nodesource.com/node_20.x nodistro InRelease Dec 26 16:03:15 volupi52 volumio[1485]: info: Hit:3 http://raspbian.raspberrypi.com/raspbian bookworm InRelease Dec 26 16:03:17 volupi52 volumio[1485]: info: Reading package lists... Dec 26 16:03:17 volupi52 sudo[9968]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:17 volupi52 volumio[1485]: info: cloning peppymeter repo Dec 26 16:03:19 volupi52 sudo[10169]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chown -R volumio /data/plugins/user_interface/peppymeterbasic /data/INTERNAL/PeppyMeterBasic/Templates Dec 26 16:03:19 volupi52 sudo[10169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:19 volupi52 sudo[10169]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:19 volupi52 sudo[10171]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chgrp -R volumio /data/plugins/user_interface/peppymeterbasic /data/INTERNAL/PeppyMeterBasic/Templates Dec 26 16:03:19 volupi52 sudo[10171]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:19 volupi52 sudo[10171]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:19 volupi52 volumio[1485]: info: installing apt packages Dec 26 16:03:19 volupi52 sudo[10173]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -yf install python3-pygame python3-pip python3-dev libjpeg-dev zlib1g-dev libfftw3-dev Dec 26 16:03:19 volupi52 sudo[10173]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:19 volupi52 volumio[1485]: info: Reading package lists... Dec 26 16:03:19 volupi52 volumio[1485]: info: Building dependency tree... Dec 26 16:03:19 volupi52 volumio[1485]: info: Reading state information... Dec 26 16:03:20 volupi52 volumio[1485]: info: python3-pip is already the newest version (23.0.1+dfsg-1+rpt1). Dec 26 16:03:20 volupi52 volumio[1485]: info: python3-dev is already the newest version (3.11.2-1). Dec 26 16:03:20 volupi52 volumio[1485]: info: libjpeg-dev is already the newest version (1:2.1.5-2). Dec 26 16:03:20 volupi52 volumio[1485]: info: zlib1g-dev is already the newest version (1:1.2.13.dfsg-1+rpt1). Dec 26 16:03:20 volupi52 volumio[1485]: info: The following additional packages will be installed: Dec 26 16:03:20 volupi52 volumio[1485]: info: libfftw3-bin libfftw3-double3 libopusfile0 libportmidi0 libsdl2-image-2.0-0 Dec 26 16:03:20 volupi52 volumio[1485]: info: libsdl2-mixer-2.0-0 libsdl2-ttf-2.0-0 python3-numpy Dec 26 16:03:20 volupi52 volumio[1485]: info: Suggested packages: Dec 26 16:03:20 volupi52 volumio[1485]: info: libfftw3-doc gcc gfortran python3-pytest python-pygame-doc timidity Dec 26 16:03:20 volupi52 volumio[1485]: info: The following NEW packages will be installed: Dec 26 16:03:20 volupi52 volumio[1485]: info: libfftw3-bin libfftw3-dev libfftw3-double3 libopusfile0 libportmidi0 Dec 26 16:03:20 volupi52 volumio[1485]: info: libsdl2-image-2.0-0 libsdl2-mixer-2.0-0 libsdl2-ttf-2.0-0 python3-numpy Dec 26 16:03:20 volupi52 volumio[1485]: info: python3-pygame Dec 26 16:03:20 volupi52 volumio[1485]: info: 0 upgraded, 10 newly installed, 0 to remove and 16 not upgraded. Dec 26 16:03:20 volupi52 volumio[1485]: info: Need to get 0 B/6289 kB of archives. Dec 26 16:03:20 volupi52 volumio[1485]: info: After this operation, 36.5 MB of additional disk space will be used. Dec 26 16:03:20 volupi52 volumio[1485]: info: Selecting previously unselected package libfftw3-double3:armhf. Dec 26 16:03:21 volupi52 volumio[1485]: [620B blob data] Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../0-libfftw3-double3_3.3.10-1_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libfftw3-double3:armhf (3.3.10-1) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package libfftw3-bin. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../1-libfftw3-bin_3.3.10-1_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libfftw3-bin (3.3.10-1) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package libfftw3-dev:armhf. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../2-libfftw3-dev_3.3.10-1_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libfftw3-dev:armhf (3.3.10-1) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package libopusfile0:armhf. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../3-libopusfile0_0.12-4_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libopusfile0:armhf (0.12-4) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package libportmidi0:armhf. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../4-libportmidi0_1%3a217-6.1_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libportmidi0:armhf (1:217-6.1) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package libsdl2-image-2.0-0:armhf. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../5-libsdl2-image-2.0-0_2.6.3+dfsg-1_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libsdl2-image-2.0-0:armhf (2.6.3+dfsg-1) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package libsdl2-mixer-2.0-0:armhf. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../6-libsdl2-mixer-2.0-0_2.6.2+dfsg-2_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libsdl2-mixer-2.0-0:armhf (2.6.2+dfsg-2) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package libsdl2-ttf-2.0-0:armhf. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../7-libsdl2-ttf-2.0-0_2.20.1+dfsg-2_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking libsdl2-ttf-2.0-0:armhf (2.20.1+dfsg-2) ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Selecting previously unselected package python3-numpy. Dec 26 16:03:21 volupi52 volumio[1485]: info: Preparing to unpack .../8-python3-numpy_1%3a1.24.2-1+deb12u1_armhf.deb ... Dec 26 16:03:21 volupi52 volumio[1485]: info: Unpacking python3-numpy (1:1.24.2-1+deb12u1) ... Dec 26 16:03:24 volupi52 volumio[1485]: info: Selecting previously unselected package python3-pygame. Dec 26 16:03:24 volupi52 volumio[1485]: info: Preparing to unpack .../9-python3-pygame_2.1.2+dfsg-5_armhf.deb ... Dec 26 16:03:24 volupi52 volumio[1485]: info: Unpacking python3-pygame (2.1.2+dfsg-5) ... Dec 26 16:03:24 volupi52 volumio[1485]: info: Setting up libsdl2-image-2.0-0:armhf (2.6.3+dfsg-1) ... Dec 26 16:03:24 volupi52 volumio[1485]: info: Setting up libportmidi0:armhf (1:217-6.1) ... Dec 26 16:03:24 volupi52 volumio[1485]: info: Setting up python3-numpy (1:1.24.2-1+deb12u1) ... Dec 26 16:03:27 volupi52 volumio[1485]: info: Setting up libfftw3-double3:armhf (3.3.10-1) ... Dec 26 16:03:27 volupi52 volumio[1485]: info: Setting up libsdl2-ttf-2.0-0:armhf (2.20.1+dfsg-2) ... Dec 26 16:03:27 volupi52 volumio[1485]: info: Setting up libopusfile0:armhf (0.12-4) ... Dec 26 16:03:27 volupi52 volumio[1485]: info: Setting up libfftw3-bin (3.3.10-1) ... Dec 26 16:03:27 volupi52 volumio[1485]: info: Setting up libsdl2-mixer-2.0-0:armhf (2.6.2+dfsg-2) ... Dec 26 16:03:27 volupi52 volumio[1485]: info: Setting up python3-pygame (2.1.2+dfsg-5) ... Dec 26 16:03:28 volupi52 volumio[1485]: info: Setting up libfftw3-dev:armhf (3.3.10-1) ... Dec 26 16:03:28 volupi52 volumio[1485]: info: Processing triggers for man-db (2.11.2-2) ... Dec 26 16:03:28 volupi52 volumio[1485]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Dec 26 16:03:28 volupi52 volumio[1485]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_mdns6_minimal.so.2 is not a symbolic link Dec 26 16:03:28 volupi52 volumio[1485]: info: Dec 26 16:03:28 volupi52 volumio[1485]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_mdns6.so.2 is not a symbolic link Dec 26 16:03:28 volupi52 volumio[1485]: info: Dec 26 16:03:28 volupi52 volumio[1485]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_mdns4_minimal.so.2 is not a symbolic link Dec 26 16:03:28 volupi52 volumio[1485]: info: Dec 26 16:03:28 volupi52 volumio[1485]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_mdns4.so.2 is not a symbolic link Dec 26 16:03:28 volupi52 volumio[1485]: info: Dec 26 16:03:28 volupi52 volumio[1485]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_mdns.so.2 is not a symbolic link Dec 26 16:03:28 volupi52 volumio[1485]: info: Dec 26 16:03:28 volupi52 volumio[1485]: info: ldconfig: /lib/arm-linux-gnueabihf/libnss_dns.so.2 is not a symbolic link Dec 26 16:03:28 volupi52 volumio[1485]: info: Dec 26 16:03:28 volupi52 sudo[10173]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:28 volupi52 sudo[10323]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Dec 26 16:03:28 volupi52 sudo[10323]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:28 volupi52 systemd[1]: Reloading. Dec 26 16:03:29 volupi52 systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:03:29 volupi52 systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Dec 26 16:03:29 volupi52 sudo[10323]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:29 volupi52 volumio[1485]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so Dec 26 16:03:29 volupi52 volumio[1485]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so.0 Dec 26 16:03:30 volupi52 sudo[10359]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/user_interface/peppymeterbasic/startpeppymeterbasic.sh Dec 26 16:03:30 volupi52 sudo[10359]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:30 volupi52 sudo[10359]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:30 volupi52 sudo[9964]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:30 volupi52 volumio[1485]: Plugin install end detected on script Dec 26 16:03:30 volupi52 volumio[1485]: info: Install script completed Dec 26 16:03:30 volupi52 volumio[1485]: info: Adding reference to registry Dec 26 16:03:30 volupi52 volumio[1485]: info: Done installing plugin. Dec 26 16:03:30 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 26 16:03:30 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 26 16:03:30 volupi52 volumio[1485]: info: Folder /tmp/plugins removed Dec 26 16:03:30 volupi52 volumio[1485]: info: Folder /tmp/downloaded_plugin.zip removed Dec 26 16:03:30 volupi52 volumio[1485]: info: Folder /data/temp removed Dec 26 16:03:32 volupi52 volumio[1485]: info: Enabling plugin peppymeterbasic Dec 26 16:03:32 volupi52 volumio[1485]: info: Loading plugin "peppymeterbasic"... Dec 26 16:03:32 volupi52 volumio[1485]: info: Preparing to generate the ALSA configuration file Dec 26 16:03:32 volupi52 volumio[1485]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 26 16:03:32 volupi52 volumio[1485]: info: Reading ALSA contributions from plugins. Dec 26 16:03:32 volupi52 volumio[1485]: info: Asound.conf file written Dec 26 16:03:32 volupi52 sudo[10363]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 26 16:03:32 volupi52 sudo[10363]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:32 volupi52 sudo[10363]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:32 volupi52 volumio[1485]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 26 16:03:32 volupi52 volumio[1485]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 26 16:03:32 volupi52 volumio[1485]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Dec 26 16:03:32 volupi52 volumio[1485]: info: Output device has changed, restarting MPD Dec 26 16:03:32 volupi52 volumio[1485]: info: Output device has changed, restarting Shairport Sync Dec 26 16:03:32 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:32 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:32 volupi52 sudo[10369]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 16:03:32 volupi52 sudo[10369]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:32 volupi52 sudo[10369]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:32 volupi52 volumio[1485]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:03:32 volupi52 volumio[1485]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 26 16:03:32 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:32 volupi52 sudo[10371]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 16:03:32 volupi52 sudo[10371]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:32 volupi52 volumio[1485]: info: QobuzConnect: setDeactiveState invoked Dec 26 16:03:32 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:32 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:32 volupi52 vtcs[9779]: [2025-12-26 16:03:32.926] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 26 16:03:32 volupi52 vtcs[9779]: [2025-12-26 16:03:32.926] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 26 16:03:32 volupi52 volumio[1485]: info: PLUGIN START: peppymeterbasic Dec 26 16:03:32 volupi52 systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 26 16:03:32 volupi52 sudo[10381]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:32 volupi52 sudo[10381]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:32 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 26 16:03:32 volupi52 volumio[1485]: info: Preparing to generate the ALSA configuration file Dec 26 16:03:32 volupi52 systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 26 16:03:32 volupi52 systemd[1]: vtcs.service: Killing process 9786 (vtcs) with signal SIGKILL. Dec 26 16:03:32 volupi52 systemd[1]: vtcs.service: Deactivated successfully. Dec 26 16:03:32 volupi52 systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 26 16:03:32 volupi52 systemd[1]: mpd.service: Deactivated successfully. Dec 26 16:03:32 volupi52 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 16:03:32 volupi52 sudo[10384]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Dec 26 16:03:32 volupi52 sudo[10384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:32 volupi52 sudo[10381]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:32 volupi52 kernel: snd_aloop snd_aloop.0: cannot find the slot for index 7 (range 0-7), error: -16 Dec 26 16:03:32 volupi52 kernel: snd_aloop snd_aloop.0: probe with driver snd_aloop failed with error -16 Dec 26 16:03:32 volupi52 kernel: aloop: No loopback enabled Dec 26 16:03:32 volupi52 systemd[1]: mpd.socket: Deactivated successfully. Dec 26 16:03:32 volupi52 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 16:03:32 volupi52 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 16:03:32 volupi52 volumio[1485]: info: Done. Dec 26 16:03:33 volupi52 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 16:03:33 volupi52 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 16:03:33 volupi52 sudo[10392]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:33 volupi52 sudo[10392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 volumio[1485]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 26 16:03:33 volupi52 volumio[1485]: info: Reading ALSA contributions from plugins. Dec 26 16:03:33 volupi52 sudo[10401]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 26 16:03:33 volupi52 sudo[10401]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 volumio[1485]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 16:03:33 volupi52 volumio[1485]: info: MPD Permissions set Dec 26 16:03:33 volupi52 sudo[10392]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 volumio[1485]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Dec 26 16:03:33 volupi52 sudo[10401]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 sudo[10384]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 sudo[10404]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 26 16:03:33 volupi52 sudo[10404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 sudo[10396]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 16:03:33 volupi52 sudo[10396]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: error: failed to load snd_dummy: Error: Command failed: /usr/bin/sudo /sbin/modprobe snd_aloop index=7 pcm_substreams=2 Dec 26 16:03:33 volupi52 volumio[1485]: modprobe: ERROR: could not insert 'snd_aloop': No such device Dec 26 16:03:33 volupi52 sudo[10396]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 volumio[1485]: info: Starting Shairport Sync Dec 26 16:03:33 volupi52 volumio[1485]: info: Asound.conf file unchanged, so no further update is needed Dec 26 16:03:33 volupi52 volumio[1485]: info: Output device has changed, restarting MPD Dec 26 16:03:33 volupi52 sudo[10414]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:03:33 volupi52 sudo[10414]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 volumio[1485]: info: Output device has changed, restarting Shairport Sync Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:33 volupi52 sudo[10416]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 16:03:33 volupi52 sudo[10416]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 sudo[10416]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 sudo[10421]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 16:03:33 volupi52 sudo[10421]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 volumio[1485]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:03:33 volupi52 volumio[1485]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: QobuzConnect: setDeactiveState invoked Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:33 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:33 volupi52 systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 26 16:03:33 volupi52 qobuz-connect[9687]: 20251226 16:03:33.144 [9687.9687] INFO SampleApp: Stopping Local configuration server Dec 26 16:03:33 volupi52 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:03:33 volupi52 systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:03:33 volupi52 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:03:33 volupi52 systemd[1]: shairport-sync.service: Consumed 1.581s CPU time. Dec 26 16:03:33 volupi52 sudo[10429]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:33 volupi52 sudo[10429]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 systemd[1]: mpd.service: Deactivated successfully. Dec 26 16:03:33 volupi52 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 16:03:33 volupi52 systemd[1]: mpd.socket: Deactivated successfully. Dec 26 16:03:33 volupi52 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 16:03:33 volupi52 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 16:03:33 volupi52 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 16:03:33 volupi52 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 16:03:33 volupi52 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:03:33 volupi52 sudo[10414]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 sudo[10438]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:33 volupi52 sudo[10438]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 sudo[10429]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 volumio[1485]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 16:03:33 volupi52 volumio[1485]: info: MPD Permissions set Dec 26 16:03:33 volupi52 volumio[1485]: info: Shairport-Sync Started Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 sudo[10457]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 26 16:03:33 volupi52 sudo[10457]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: Starting Shairport Sync Dec 26 16:03:33 volupi52 sudo[10435]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 16:03:33 volupi52 sudo[10435]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:33 volupi52 sudo[10468]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:03:33 volupi52 sudo[10435]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 sudo[10468]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 sudo[10457]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 sudo[10471]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 26 16:03:33 volupi52 sudo[10471]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:33 volupi52 sudo[10438]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:03:33 volupi52 systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:03:33 volupi52 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:03:33 volupi52 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:03:33 volupi52 sudo[10468]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 volumio[1485]: info: Shairport-Sync Started Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:33 volupi52 mpd[10472]: 2025-12-26T16:03:33 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 26 16:03:33 volupi52 systemd[1]: Started mpd.service - Music Player Daemon. Dec 26 16:03:33 volupi52 sudo[10371]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 sudo[10421]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:33 volupi52 volumio[1485]: error: MPD error: The expression evaluated to a falsy value: Dec 26 16:03:33 volupi52 volumio[1485]: assert.ok(self.idling) Dec 26 16:03:33 volupi52 volumio[1485]: error: The expression evaluated to a falsy value: Dec 26 16:03:33 volupi52 volumio[1485]: assert.ok(self.idling) Dec 26 16:03:33 volupi52 volumio[1485]: error: updateQueue error: null Dec 26 16:03:34 volupi52 qobuz-connect[9687]: 20251226 16:03:34.692 [9687.9687] INFO SampleApp: shat down connection on UNIX socket Dec 26 16:03:34 volupi52 volumio[1485]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 26 16:03:34 volupi52 volumio[1485]: info: QobuzConnect: setDeactiveState invoked Dec 26 16:03:34 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:34 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:34 volupi52 systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 26 16:03:34 volupi52 systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 26 16:03:34 volupi52 systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 26 16:03:34 volupi52 sudo[10471]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:34 volupi52 sudo[10404]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:34 volupi52 volumio[1485]: info: Executing endpoint qc_getconfig Dec 26 16:03:34 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.758 [10492.10492] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 26 16:03:34 volupi52 volumio[1485]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 26 16:03:34 volupi52 volumio[1485]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.761 [10492.10492] INFO VolumeManager: [0x107b178]: Setting new playback volume: 75 Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.761 [10492.10492] INFO VolumeManager: [0x107b178]: Setting new mute state: 0 Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.761 [10492.10492] INFO QobuzConnect: [0x107bb48]: Client initialized! Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.761 [10492.10492] INFO SampleApp: Starting Avahi advertising, name: Volupi52, service name: _qobuz-connect._tcp Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.767 [10492.10492] INFO LocalConfigManager: [0x107aa58]: Starting Local Configuration server Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.767 [10492.10492] INFO SampleApp: Starting Local configuration server Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.767 [10492.10492] INFO SampleApp: Connected to UNIX socket client 0x1065818 Dec 26 16:03:34 volupi52 qobuz-connect[10492]: 20251226 16:03:34.907 [10492.10492] INFO SampleApp: Playback volume changed: 75 Dec 26 16:03:34 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:34 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:35 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:36 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:36 volupi52 volumio[1485]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:36 volupi52 volumio[1485]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:36 volupi52 sudo[10507]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 26 16:03:36 volupi52 sudo[10507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:36 volupi52 systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 26 16:03:36 volupi52 sudo[10507]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:36 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:36 volupi52 volumio[1485]: info: Executing endpoint tc_getconfig Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 26 16:03:36 volupi52 vtcs[10510]: STARTING TidalConnect services, version: 1.5.2.56 Dec 26 16:03:36 volupi52 vtcs[10510]: STARTED TidalConnect services. Dec 26 16:03:36 volupi52 volumio[1485]: info: Executing endpoint tc_connect Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 26 16:03:36 volupi52 volumio[1485]: info: Connecting to TidalConnect Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::servicePushState Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreStateMachine::pushState Dec 26 16:03:36 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::volumioPushState Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:36 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:36 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:36 volupi52 volumio[1485]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::servicePushState Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreStateMachine::pushState Dec 26 16:03:36 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::volumioPushState Dec 26 16:03:36 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:36 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:36 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:36 volupi52 volumio[1485]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Dec 26 16:03:36 volupi52 volumio[1485]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 26 16:03:36 volupi52 volumio[1485]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 26 16:03:36 volupi52 sudo[10523]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 26 16:03:36 volupi52 sudo[10523]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:36 volupi52 sudo[10525]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 26 16:03:36 volupi52 sudo[10525]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:36 volupi52 sudo[10525]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:36 volupi52 volumio[1485]: info: peppymeterbasic Daemon Stop Dec 26 16:03:36 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:36 volupi52 sudo[10523]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:36 volupi52 volumio[1485]: info: peppymeterbasic Daemon Stop Dec 26 16:03:36 volupi52 volumio[1485]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:36 volupi52 volumio[1485]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:36 volupi52 sudo[10541]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 26 16:03:36 volupi52 sudo[10541]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:36 volupi52 sudo[10541]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:39 volupi52 volumio[1485]: info: TidalConnect service started! Dec 26 16:03:39 volupi52 volumio[1485]: info: TidalConnect service started! Dec 26 16:03:45 volupi52 volumio[1485]: info: Enabling plugin peppymeterbasic Dec 26 16:03:45 volupi52 volumio[1485]: info: Loading plugin "peppymeterbasic"... Dec 26 16:03:45 volupi52 volumio[1485]: info: Preparing to generate the ALSA configuration file Dec 26 16:03:45 volupi52 volumio[1485]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 26 16:03:45 volupi52 volumio[1485]: info: Reading ALSA contributions from plugins. Dec 26 16:03:45 volupi52 volumio[1485]: info: Asound.conf file unchanged, so no further update is needed Dec 26 16:03:45 volupi52 volumio[1485]: info: Output device has changed, restarting MPD Dec 26 16:03:45 volupi52 volumio[1485]: info: Output device has changed, restarting Shairport Sync Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:45 volupi52 sudo[10559]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 16:03:45 volupi52 sudo[10559]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 sudo[10559]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10561]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 16:03:45 volupi52 sudo[10561]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 volumio[1485]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:03:45 volupi52 volumio[1485]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: QobuzConnect: setDeactiveState invoked Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:45 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:45 volupi52 vtcs[10510]: [2025-12-26 16:03:45.405] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 26 16:03:45 volupi52 vtcs[10510]: [2025-12-26 16:03:45.406] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 26 16:03:45 volupi52 systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 26 16:03:45 volupi52 volumio[1485]: info: PLUGIN START: peppymeterbasic Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 26 16:03:45 volupi52 volumio[1485]: info: Preparing to generate the ALSA configuration file Dec 26 16:03:45 volupi52 sudo[10571]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:45 volupi52 sudo[10571]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 systemd[1]: mpd.service: Deactivated successfully. Dec 26 16:03:45 volupi52 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 16:03:45 volupi52 sudo[10573]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Dec 26 16:03:45 volupi52 sudo[10573]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 volumio[1485]: info: Done. Dec 26 16:03:45 volupi52 systemd[1]: mpd.socket: Deactivated successfully. Dec 26 16:03:45 volupi52 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 16:03:45 volupi52 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 16:03:45 volupi52 kernel: snd_aloop snd_aloop.0: cannot find the slot for index 7 (range 0-7), error: -16 Dec 26 16:03:45 volupi52 kernel: snd_aloop snd_aloop.0: probe with driver snd_aloop failed with error -16 Dec 26 16:03:45 volupi52 kernel: aloop: No loopback enabled Dec 26 16:03:45 volupi52 sudo[10580]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:45 volupi52 sudo[10580]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 16:03:45 volupi52 volumio[1485]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 26 16:03:45 volupi52 volumio[1485]: info: Reading ALSA contributions from plugins. Dec 26 16:03:45 volupi52 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 16:03:45 volupi52 volumio[1485]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 16:03:45 volupi52 volumio[1485]: info: MPD Permissions set Dec 26 16:03:45 volupi52 systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Dec 26 16:03:45 volupi52 systemd[1]: vtcs.service: Killing process 10517 (vtcs) with signal SIGKILL. Dec 26 16:03:45 volupi52 volumio[1485]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12 Dec 26 16:03:45 volupi52 sudo[10587]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 26 16:03:45 volupi52 systemd[1]: vtcs.service: Deactivated successfully. Dec 26 16:03:45 volupi52 sudo[10587]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 sudo[10580]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10573]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 volumio[1485]: info: Starting Shairport Sync Dec 26 16:03:45 volupi52 volumio[1485]: error: failed to load snd_dummy: Error: Command failed: /usr/bin/sudo /sbin/modprobe snd_aloop index=7 pcm_substreams=2 Dec 26 16:03:45 volupi52 volumio[1485]: modprobe: ERROR: could not insert 'snd_aloop': No such device Dec 26 16:03:45 volupi52 volumio[1485]: info: Asound.conf file unchanged, so no further update is needed Dec 26 16:03:45 volupi52 volumio[1485]: info: Output device has changed, restarting MPD Dec 26 16:03:45 volupi52 sudo[10571]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 volumio[1485]: info: Output device has changed, restarting Shairport Sync Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:45 volupi52 sudo[10598]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:03:45 volupi52 sudo[10587]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10598]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 sudo[10588]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 16:03:45 volupi52 sudo[10588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:45 volupi52 sudo[10588]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10603]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 26 16:03:45 volupi52 sudo[10603]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 sudo[10600]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 26 16:03:45 volupi52 sudo[10600]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 volumio[1485]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 26 16:03:45 volupi52 volumio[1485]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 sudo[10600]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10607]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 26 16:03:45 volupi52 sudo[10607]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 volumio[1485]: info: QobuzConnect: setDeactiveState invoked Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:45 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:45 volupi52 sudo[10619]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:45 volupi52 sudo[10619]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 sudo[10624]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 26 16:03:45 volupi52 sudo[10624]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 volumio[1485]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read properties of undefined (reading 'split') Dec 26 16:03:45 volupi52 volumio[1485]: info: MPD Permissions set Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 sudo[10631]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 26 16:03:45 volupi52 systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Dec 26 16:03:45 volupi52 systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 26 16:03:45 volupi52 qobuz-connect[10492]: 20251226 16:03:45.613 [10492.10492] INFO SampleApp: Stopping Local configuration server Dec 26 16:03:45 volupi52 sudo[10631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 systemd[1]: shairport-sync.service: Deactivated successfully. Dec 26 16:03:45 volupi52 systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:03:45 volupi52 systemd[1]: shairport-sync.service: Consumed 1.529s CPU time. Dec 26 16:03:45 volupi52 volumio[1485]: info: Starting Shairport Sync Dec 26 16:03:45 volupi52 systemd[1]: mpd.service: Deactivated successfully. Dec 26 16:03:45 volupi52 systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 26 16:03:45 volupi52 sudo[10639]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 26 16:03:45 volupi52 sudo[10639]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 sudo[10619]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10631]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10624]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 sudo[10642]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 26 16:03:45 volupi52 sudo[10642]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:45 volupi52 systemd[1]: mpd.socket: Deactivated successfully. Dec 26 16:03:45 volupi52 systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 26 16:03:45 volupi52 systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 26 16:03:45 volupi52 systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 26 16:03:45 volupi52 systemd[1]: Starting mpd.service - Music Player Daemon... Dec 26 16:03:45 volupi52 systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 26 16:03:45 volupi52 sudo[10598]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 volumio[1485]: info: Shairport-Sync Started Dec 26 16:03:45 volupi52 sudo[10639]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 volumio[1485]: info: Shairport-Sync Started Dec 26 16:03:45 volupi52 sudo[10646]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 26 16:03:45 volupi52 sudo[10646]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 26 16:03:45 volupi52 sudo[10646]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:45 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:46 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:46 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 26 16:03:46 volupi52 mpd[10663]: 2025-12-26T16:03:46 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 26 16:03:46 volupi52 systemd[1]: Started mpd.service - Music Player Daemon. Dec 26 16:03:46 volupi52 sudo[10603]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:46 volupi52 sudo[10561]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:46 volupi52 volumio[1485]: error: MPD error: The expression evaluated to a falsy value: Dec 26 16:03:46 volupi52 volumio[1485]: assert.ok(self.idling) Dec 26 16:03:46 volupi52 volumio[1485]: error: The expression evaluated to a falsy value: Dec 26 16:03:46 volupi52 volumio[1485]: assert.ok(self.idling) Dec 26 16:03:46 volupi52 volumio[1485]: error: updateQueue error: null Dec 26 16:03:46 volupi52 qobuz-connect[10492]: 20251226 16:03:46.781 [10492.10492] INFO SampleApp: shat down connection on UNIX socket Dec 26 16:03:46 volupi52 volumio[1485]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 26 16:03:46 volupi52 volumio[1485]: info: QobuzConnect: setDeactiveState invoked Dec 26 16:03:46 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:46 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:46 volupi52 systemd[1]: qobuz-connect.service: Deactivated successfully. Dec 26 16:03:46 volupi52 systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Dec 26 16:03:46 volupi52 systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Dec 26 16:03:46 volupi52 sudo[10607]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:46 volupi52 sudo[10642]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:46 volupi52 volumio[1485]: info: Executing endpoint qc_getconfig Dec 26 16:03:46 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.848 [10666.10666] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 26 16:03:46 volupi52 volumio[1485]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 26 16:03:46 volupi52 volumio[1485]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.850 [10666.10666] INFO VolumeManager: [0x6fb178]: Setting new playback volume: 75 Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.850 [10666.10666] INFO VolumeManager: [0x6fb178]: Setting new mute state: 0 Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.850 [10666.10666] INFO QobuzConnect: [0x6fbb48]: Client initialized! Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.850 [10666.10666] INFO SampleApp: Starting Avahi advertising, name: Volupi52, service name: _qobuz-connect._tcp Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.858 [10666.10666] INFO LocalConfigManager: [0x6faa58]: Starting Local Configuration server Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.858 [10666.10666] INFO SampleApp: Starting Local configuration server Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.858 [10666.10666] INFO SampleApp: Connected to UNIX socket client 0x6e5818 Dec 26 16:03:46 volupi52 qobuz-connect[10666]: 20251226 16:03:46.997 [10666.10666] INFO SampleApp: Playback volume changed: 75 Dec 26 16:03:46 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:46 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:48 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:48 volupi52 volumio[1485]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:48 volupi52 volumio[1485]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:48 volupi52 sudo[10681]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 26 16:03:48 volupi52 sudo[10681]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:48 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:48 volupi52 systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Dec 26 16:03:48 volupi52 sudo[10681]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:48 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:48 volupi52 volumio[1485]: info: TidalConnect service stoped! Dec 26 16:03:48 volupi52 volumio[1485]: info: Executing endpoint tc_getconfig Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 26 16:03:48 volupi52 vtcs[10684]: STARTING TidalConnect services, version: 1.5.2.56 Dec 26 16:03:48 volupi52 volumio[1485]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:48 volupi52 volumio[1485]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 26 16:03:48 volupi52 vtcs[10684]: STARTED TidalConnect services. Dec 26 16:03:48 volupi52 volumio[1485]: info: Executing endpoint tc_connect Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 26 16:03:48 volupi52 volumio[1485]: info: Connecting to TidalConnect Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::servicePushState Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreStateMachine::pushState Dec 26 16:03:48 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::volumioPushState Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:48 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:48 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:48 volupi52 volumio[1485]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::servicePushState Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreStateMachine::pushState Dec 26 16:03:48 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::volumioPushState Dec 26 16:03:48 volupi52 volumio[1485]: info: CoreCommandRouter::volumioGetState Dec 26 16:03:48 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:48 volupi52 volumio[1485]: info: CorePlayQueue::getTrack 0 Dec 26 16:03:48 volupi52 volumio[1485]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Dec 26 16:03:48 volupi52 sudo[10705]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 26 16:03:48 volupi52 sudo[10705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:48 volupi52 volumio[1485]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 26 16:03:48 volupi52 volumio[1485]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 26 16:03:48 volupi52 sudo[10711]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 26 16:03:48 volupi52 sudo[10711]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:48 volupi52 volumio[1485]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 26 16:03:48 volupi52 sudo[10705]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:48 volupi52 sudo[10714]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 26 16:03:48 volupi52 sudo[10714]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:48 volupi52 volumio[1485]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 26 16:03:48 volupi52 sudo[10717]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 26 16:03:48 volupi52 sudo[10717]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:48 volupi52 sudo[10721]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 26 16:03:48 volupi52 sudo[10721]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 26 16:03:48 volupi52 sudo[10711]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:48 volupi52 sudo[10714]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:48 volupi52 volumio[1485]: info: peppymeterbasic Daemon Stop Dec 26 16:03:48 volupi52 volumio[1485]: info: peppymeterbasic Daemon Stop Dec 26 16:03:48 volupi52 sudo[10717]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:48 volupi52 volumio[1485]: info: peppymeterbasic Daemon Stop Dec 26 16:03:48 volupi52 sudo[10721]: pam_unix(sudo:session): session closed for user root Dec 26 16:03:48 volupi52 volumio[1485]: info: peppymeterbasic Daemon Stop Dec 26 16:03:51 volupi52 volumio[1485]: info: TidalConnect service started! Dec 26 16:03:51 volupi52 volumio[1485]: info: TidalConnect service started! Dec 26 16:04:06 volupi52 volumio[1485]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 26 16:04:47 volupi52 volumio[1485]: info: CALLMETHOD: user_interface peppymeterbasic dlmeter [object Object] Dec 26 16:04:47 volupi52 volumio[1485]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , dlmeter Dec 26 16:04:48 volupi52 volumio[1485]: --2025-12-26 16:04:47-- https://github.com/balbuze/Meter-peppymeter/raw/main/Zipped-folders/Choose Dec 26 16:04:48 volupi52 volumio[1485]: Resolving github.com (github.com)... 4.225.11.194 Dec 26 16:04:48 volupi52 volumio[1485]: Connecting to github.com (github.com)|4.225.11.194|:443... connected. Dec 26 16:04:48 volupi52 volumio[1485]: HTTP request sent, awaiting response... 404 Not Found Dec 26 16:04:48 volupi52 volumio[1485]: 2025-12-26 16:04:47 ERROR 404: Not Found. Dec 26 16:04:48 volupi52 volumio[1485]: --2025-12-26 16:04:47-- http://a/ Dec 26 16:04:48 volupi52 volumio[1485]: Resolving a (a)... failed: Device or resource busy. Dec 26 16:04:48 volupi52 volumio[1485]: wget: unable to resolve host address ‘a’ Dec 26 16:04:48 volupi52 volumio[1485]: --2025-12-26 16:04:47-- http://packet.zip/ Dec 26 16:04:48 volupi52 volumio[1485]: Resolving packet.zip (packet.zip)... 162.255.119.167 Dec 26 16:04:48 volupi52 volumio[1485]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Dec 26 16:04:48 volupi52 volumio[1485]: HTTP request sent, awaiting response... 302 Found Dec 26 16:04:48 volupi52 volumio[1485]: Location: http://www.packet.zip/ [following] Dec 26 16:04:48 volupi52 volumio[1485]: --2025-12-26 16:04:48-- http://www.packet.zip/ Dec 26 16:04:48 volupi52 volumio[1485]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Dec 26 16:04:48 volupi52 volumio[1485]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Dec 26 16:04:48 volupi52 volumio[1485]: HTTP request sent, awaiting response... 403 Forbidden Dec 26 16:04:48 volupi52 volumio[1485]: 2025-12-26 16:04:48 ERROR 403: Forbidden. Dec 26 16:04:48 volupi52 volumio[1485]: error: PeppyMeterBasic --- An error occurs while downloading or installing Meters Dec 26 16:04:48 volupi52 volumio[1485]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 26 16:04:48 volupi52 volumio[1485]: /bin/rm: cannot remove 'a': No such file or directory Dec 26 16:04:48 volupi52 volumio[1485]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 26 16:04:48 volupi52 volumio[1485]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 16:04:48 volupi52 volumio[1485]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Dec 26 16:04:48 volupi52 volumio[1485]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 26 16:04:48 volupi52 volumio[1485]: /bin/rm: cannot remove 'a': No such file or directory Dec 26 16:04:48 volupi52 volumio[1485]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 26 16:04:48 volupi52 volumio[1485]: at checkExecSyncError (node:child_process:887:11) Dec 26 16:04:48 volupi52 volumio[1485]: at execSync (node:child_process:959:15) Dec 26 16:04:48 volupi52 volumio[1485]: at /data/plugins/user_interface/peppymeterbasic/index.js:710:19 Dec 26 16:04:48 volupi52 volumio[1485]: at new Promise () Dec 26 16:04:48 volupi52 volumio[1485]: at peppymeterbasic.dlmeter (/data/plugins/user_interface/peppymeterbasic/index.js:685:12) Dec 26 16:04:48 volupi52 volumio[1485]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 26 16:04:48 volupi52 volumio[1485]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Dec 26 16:04:48 volupi52 volumio[1485]: at Socket.emit (node:events:514:28) Dec 26 16:04:48 volupi52 volumio[1485]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 26 16:04:48 volupi52 volumio[1485]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Dec 26 16:04:48 volupi52 volumio[1485]: status: 1, Dec 26 16:04:48 volupi52 volumio[1485]: signal: null, Dec 26 16:04:48 volupi52 volumio[1485]: output: [ Dec 26 16:04:48 volupi52 volumio[1485]: null, Dec 26 16:04:48 volupi52 volumio[1485]: , Dec 26 16:04:48 volupi52 volumio[1485]: Dec 26 16:04:48 volupi52 volumio[1485]: ], Dec 26 16:04:48 volupi52 volumio[1485]: pid: 10816, Dec 26 16:04:48 volupi52 volumio[1485]: stdout: , Dec 26 16:04:48 volupi52 volumio[1485]: stderr: Dec 26 16:04:48 volupi52 volumio[1485]: } Dec 26 16:04:48 volupi52 volumio[1485]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 26 16:04:49 volupi52 sudo[10835]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-26 16:03' Dec 26 16:04:49 volupi52 sudo[10835]: 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="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"