-- Logs begin at Thu 2019-02-14 07:11:59 -03, end at Sun 2025-12-07 04:28:22 -03. -- Dec 07 04:27:00 volumio volumio[867]: info: Checking if install.sh is present Dec 07 04:27:00 volumio volumio[867]: info: Executing install.sh Dec 07 04:27:00 volumio sudo[7343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Dec 07 04:27:00 volumio sudo[7343]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:00 volumio volumio[867]: info: creating filters folder and copying demo filters Dec 07 04:27:00 volumio volumio[867]: info: copying demo flters Dec 07 04:27:00 volumio volumio[867]: info: ./presets/ Dec 07 04:27:00 volumio volumio[867]: info: ./presets/2XEQ15/ Dec 07 04:27:00 volumio volumio[867]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Dec 07 04:27:00 volumio sudo[7368]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Dec 07 04:27:00 volumio sudo[7368]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:00 volumio volumio[867]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/PEQ/ Dec 07 04:27:00 volumio volumio[867]: info: ./presets/convfir/ Dec 07 04:27:00 volumio volumio[867]: info: ./presets/convfir/kef.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/convfir/test.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/EQ15/ Dec 07 04:27:00 volumio volumio[867]: info: ./presets/EQ15/.Bass-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/EQ15/.Classic-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/EQ15/.Voice-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: ./presets/EQ15/.Rock-FusionDsp.json Dec 07 04:27:00 volumio volumio[867]: info: Installing/fusiondsp dependencies Dec 07 04:27:00 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 07 04:27:00 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 07 04:27:00 volumio volumio[867]: info: Discovery: Getting this device information Dec 07 04:27:00 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:00 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:00 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 07 04:27:00 volumio volumio[867]: verbose: New Socket.io Connection to 192.168.1.10:3000 from 192.168.1.4 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8 Dec 07 04:27:00 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 07 04:27:00 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 07 04:27:01 volumio volumio[867]: info: Get:1 https://deb.nodesource.com/node_14.x buster InRelease [4584 B] Dec 07 04:27:01 volumio volumio[867]: info: Ign:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Dec 07 04:27:01 volumio volumio[867]: info: Get:3 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] Dec 07 04:27:01 volumio volumio[867]: info: Err:4 http://raspbian.raspberrypi.org/raspbian buster Release Dec 07 04:27:01 volumio volumio[867]: info: 404 Not Found [IP: 93.93.128.193 80] Dec 07 04:27:01 volumio volumio[867]: info: Get:5 https://deb.nodesource.com/node_14.x buster/main armhf Packages [786 B] Dec 07 04:27:02 volumio volumio[867]: info: Get:6 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] Dec 07 04:27:03 volumio volumio[867]: info: Reading package lists... Dec 07 04:27:03 volumio sudo[7368]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:03 volumio sudo[7508]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Dec 07 04:27:03 volumio sudo[7508]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:03 volumio volumio[867]: info: Reading package lists... Dec 07 04:27:03 volumio volumio[867]: info: Building dependency tree... Dec 07 04:27:03 volumio volumio[867]: info: Reading state information... Dec 07 04:27:03 volumio sudo[7508]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:03 volumio sudo[7512]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Dec 07 04:27:03 volumio sudo[7512]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:03 volumio volumio[867]: info: lib/systemd/system/fusiondsp.service Dec 07 04:27:03 volumio sudo[7512]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:05 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 07 04:27:05 volumio volumio[867]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Dec 07 04:27:05 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Dec 07 04:27:05 volumio volumio[867]: info: Received Get System Version Dec 07 04:27:05 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 07 04:27:05 volumio volumio[867]: info: Received Get System Info Dec 07 04:27:05 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 07 04:27:05 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 07 04:27:05 volumio volumio[867]: info: Discovery: Getting this device information Dec 07 04:27:05 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:05 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:05 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 07 04:27:06 volumio volumio[867]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Dec 07 04:27:06 volumio volumio[867]: info: more info at http://www.winimage.com/zLibDll/unzip.html Dec 07 04:27:06 volumio volumio[867]: info: Dec 07 04:27:06 volumio volumio[867]: info: cgui-1.0.0.zip opened Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/ Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/LICENSE.txt Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/README.md Dec 07 04:27:06 volumio sudo[7519]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/build/ Dec 07 04:27:06 volumio sudo[7519]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/robots.txt Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/logo512.png Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/asset-manifest.json Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/index.html Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/.put_statics_here Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/favicon.ico Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/logo192.png Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Dec 07 04:27:06 volumio sudo[7519]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/manifest.json Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/css-variables.css Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/service-worker.js Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/build/static/ Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/build/static/css/ Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Dec 07 04:27:06 volumio sudo[7521]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/main.1503f6cd.css Dec 07 04:27:06 volumio sudo[7521]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/build/static/media/ Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/build/static/js/ Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/main.71e11955.js Dec 07 04:27:06 volumio sudo[7521]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/main.71e11955.js.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Dec 07 04:27:06 volumio sudo[7523]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/config/ Dec 07 04:27:06 volumio sudo[7523]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/config/camillagui.yml Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/config/gui-config.yml Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/backend/ Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/filters_test.py Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/version.py Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/filters.py Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/settings.py Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/views.py Dec 07 04:27:06 volumio sudo[7523]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/filterdefaults.py Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__init__.py Dec 07 04:27:06 volumio volumio[867]: info: creating directory: cgui/backend/__pycache__/ Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/routes.py Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/backend/filemanagement.py Dec 07 04:27:06 volumio volumio[867]: info: extracting: cgui/main.py Dec 07 04:27:06 volumio volumio[867]: info: copying hw detection script Dec 07 04:27:06 volumio volumio[867]: info: Detected cpu architecture as armv7l Dec 07 04:27:07 volumio sudo[7536]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params Dec 07 04:27:07 volumio sudo[7536]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:07 volumio sudo[7536]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:07 volumio sudo[7538]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Dec 07 04:27:07 volumio sudo[7538]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:07 volumio sudo[7538]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:07 volumio sudo[7540]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Dec 07 04:27:07 volumio sudo[7540]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:08 volumio volumio[867]: info: Reading package lists... Dec 07 04:27:08 volumio volumio[867]: info: Building dependency tree... Dec 07 04:27:08 volumio volumio[867]: info: Reading state information... Dec 07 04:27:08 volumio sudo[7540]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:08 volumio sudo[7343]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:08 volumio volumio[867]: info: Install script completed Dec 07 04:27:08 volumio volumio[867]: info: Adding reference to registry Dec 07 04:27:08 volumio volumio[867]: info: Done installing plugin. Dec 07 04:27:08 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 07 04:27:08 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 07 04:27:08 volumio volumio[867]: info: Folder /tmp/plugins removed Dec 07 04:27:08 volumio volumio[867]: info: Folder /tmp/downloaded_plugin.zip removed Dec 07 04:27:08 volumio volumio[867]: Plugin install end detected on script Dec 07 04:27:08 volumio volumio[867]: info: Folder /data/temp removed Dec 07 04:27:10 volumio volumio[867]: info: Enabling plugin fusiondsp Dec 07 04:27:10 volumio volumio[867]: info: Loading plugin "fusiondsp"... Dec 07 04:27:10 volumio volumio[867]: info: Preparing to generate the ALSA configuration file Dec 07 04:27:10 volumio volumio[867]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 07 04:27:10 volumio volumio[867]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 07 04:27:10 volumio volumio[867]: info: Reading ALSA contributions from plugins. Dec 07 04:27:10 volumio volumio[867]: info: Asound.conf file written Dec 07 04:27:10 volumio sudo[7559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 07 04:27:10 volumio sudo[7559]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:10 volumio sudo[7559]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:10 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:27:10 volumio volumio[867]: No state is present for card b1 Dec 07 04:27:10 volumio volumio[867]: /usr/share/alsa/init/bcm2835:14: control element not found Dec 07 04:27:10 volumio volumio[867]: No state is present for card b1 Dec 07 04:27:10 volumio volumio[867]: No state is present for card Headphones Dec 07 04:27:10 volumio volumio[867]: /usr/share/alsa/init/bcm2835:20: control element not found Dec 07 04:27:10 volumio volumio[867]: No state is present for card Headphones Dec 07 04:27:10 volumio volumio[867]: No state is present for card IQaudIODAC Dec 07 04:27:10 volumio volumio[867]: Found hardware: "IQaudIODAC" "" "" "" "" Dec 07 04:27:10 volumio volumio[867]: Hardware is initialized using a generic method Dec 07 04:27:10 volumio volumio[867]: No state is present for card IQaudIODAC Dec 07 04:27:10 volumio volumio[867]: info: Output device has changed, restarting MPD Dec 07 04:27:10 volumio sudo[7564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 07 04:27:10 volumio sudo[7564]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:10 volumio volumio[867]: info: Output device has changed, restarting Shairport Sync Dec 07 04:27:10 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:10 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:27:10 volumio sudo[7564]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:10 volumio sudo[7567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 07 04:27:10 volumio sudo[7567]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:10 volumio systemd[1]: Stopping Music Player Daemon... Dec 07 04:27:10 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:27:10 volumio volumio[867]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 07 04:27:10 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:27:10 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 07 04:27:10 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:10 volumio systemd[1]: mpd.service: Succeeded. Dec 07 04:27:10 volumio systemd[1]: Stopped Music Player Daemon. Dec 07 04:27:10 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:27:10 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:10 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:10 volumio vtcs[5042]: [2025-12-07 04:27:10.935] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 07 04:27:10 volumio vtcs[5042]: [2025-12-07 04:27:10.965] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer Dec 07 04:27:10 volumio vtcs[5042]: [2025-12-07 04:27:10.965] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 07 04:27:10 volumio systemd[1]: Starting Music Player Daemon... Dec 07 04:27:10 volumio volumio[867]: info: PLUGIN START: fusiondsp Dec 07 04:27:11 volumio volumio[867]: info: Loading i18n strings for locale es Dec 07 04:27:11 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 07 04:27:11 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:11 volumio volumio[867]: info: FusionDsp - mixtype--------------------- Hardware Dec 07 04:27:11 volumio volumio[867]: info: Preparing to generate the ALSA configuration file Dec 07 04:27:11 volumio sudo[7578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:27:11 volumio sudo[7578]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:11 volumio volumio[867]: info: Done. Dec 07 04:27:11 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Dec 07 04:27:11 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 07 04:27:11 volumio systemd[1]: vtcs.service: Succeeded. Dec 07 04:27:11 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Dec 07 04:27:11 volumio sudo[7578]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:11 volumio sudo[7581]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:27:11 volumio sudo[7581]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:11 volumio sudo[7573]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 07 04:27:11 volumio sudo[7573]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:11 volumio sudo[7573]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:11 volumio volumio[867]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 07 04:27:11 volumio volumio[867]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 07 04:27:11 volumio volumio[867]: info: Reading ALSA contributions from plugins. Dec 07 04:27:11 volumio sudo[7590]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 07 04:27:11 volumio sudo[7590]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:11 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:11 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:27:11 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:11 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 04:27:11 volumio volumio[867]: info: MPD Permissions set Dec 07 04:27:11 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:11 volumio sudo[7581]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:11 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:27:11 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:11 volumio sudo[7590]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:11 volumio sudo[7596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 07 04:27:11 volumio sudo[7596]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:11 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 07 04:27:11 volumio qobuz-connect[5000]: 20251207 04:27:11.289 [5000.5000] INFO SampleApp: Stopping Local configuration server Dec 07 04:27:11 volumio qobuz-connect[5000]: 20251207 04:27:11.300 [5000.5000] INFO SampleApp: shat down connection on UNIX socket Dec 07 04:27:11 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 07 04:27:11 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 07 04:27:11 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 07 04:27:11 volumio sudo[7596]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:12 volumio volumio[867]: info: FusionDsp - Dec 07 04:27:12 volumio mpd[7589]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 07 04:27:12 volumio mpd[7589]: output: No 'audio_output' defined in config file Dec 07 04:27:12 volumio mpd[7589]: output: Successfully detected a sndio audio device Dec 07 04:27:12 volumio mpd[7589]: zeroconf: No global port, disabling zeroconf Dec 07 04:27:12 volumio systemd[1]: Started Music Player Daemon. Dec 07 04:27:12 volumio sudo[7567]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:12 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:12 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:27:12 volumio volumio[867]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 07 04:27:12 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:27:12 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:12 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:12 volumio volumio[867]: info: FusionDsp - undefined Dec 07 04:27:12 volumio volumio[867]: info: Starting Shairport Sync Dec 07 04:27:12 volumio sudo[7605]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 07 04:27:12 volumio sudo[7605]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:12 volumio volumio[867]: info: Executing endpoint qc_getconfig Dec 07 04:27:12 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.671 [7599.7599] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.681 [7599.7599] INFO VolumeManager: [0x1059550]: Setting new playback volume: 75 Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.681 [7599.7599] INFO VolumeManager: [0x1059550]: Setting new mute state: 0 Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.681 [7599.7599] INFO QobuzConnect: [0x1059f20]: Client initialized! Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.682 [7599.7599] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 07 04:27:12 volumio volumio[867]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 07 04:27:12 volumio volumio[867]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.694 [7599.7599] INFO LocalConfigManager: [0x1058e30]: Starting Local Configuration server Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.694 [7599.7599] INFO SampleApp: Starting Local configuration server Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.695 [7599.7599] INFO SampleApp: Connected to UNIX socket client 0x104ef60 Dec 07 04:27:12 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 07 04:27:12 volumio volumio[867]: info: Asound.conf file unchanged, so no further update is needed Dec 07 04:27:12 volumio volumio[867]: info: Output device has changed, restarting MPD Dec 07 04:27:12 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 07 04:27:12 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 07 04:27:12 volumio sudo[7610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 07 04:27:12 volumio sudo[7610]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:12 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 07 04:27:12 volumio volumio[867]: info: Output device has changed, restarting Shairport Sync Dec 07 04:27:12 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:12 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:27:12 volumio sudo[7610]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:12 volumio sudo[7613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 07 04:27:12 volumio sudo[7605]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:12 volumio sudo[7613]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:12 volumio systemd[1]: Stopping Music Player Daemon... Dec 07 04:27:12 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:27:12 volumio volumio[867]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 07 04:27:12 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:27:12 volumio qobuz-connect[7599]: 20251207 04:27:12.821 [7599.7599] INFO SampleApp: Playback volume changed: 75 Dec 07 04:27:12 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 07 04:27:12 volumio systemd[1]: mpd.service: Succeeded. Dec 07 04:27:12 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:12 volumio systemd[1]: Stopped Music Player Daemon. Dec 07 04:27:12 volumio systemd[1]: Starting Music Player Daemon... Dec 07 04:27:12 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:27:12 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:12 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:12 volumio sudo[7625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:27:12 volumio sudo[7625]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:12 volumio sudo[7629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:27:12 volumio sudo[7629]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:12 volumio sudo[7625]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:12 volumio sudo[7621]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 07 04:27:12 volumio sudo[7621]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:12 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:12 volumio sudo[7621]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:12 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:27:12 volumio sudo[7636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 07 04:27:12 volumio sudo[7636]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:13 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:13 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:27:13 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:13 volumio sudo[7629]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:13 volumio sudo[7636]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:13 volumio volumio[867]: error: updateQueue error: null Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:13 volumio volumio[867]: info: MPD Permissions set Dec 07 04:27:13 volumio volumio[867]: info: Shairport-Sync Started Dec 07 04:27:13 volumio sudo[7641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 07 04:27:13 volumio sudo[7641]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:13 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 07 04:27:13 volumio qobuz-connect[7599]: 20251207 04:27:13.125 [7599.7599] INFO SampleApp: Stopping Local configuration server Dec 07 04:27:13 volumio qobuz-connect[7599]: 20251207 04:27:13.137 [7599.7599] INFO SampleApp: shat down connection on UNIX socket Dec 07 04:27:13 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 07 04:27:13 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 07 04:27:13 volumio volumio[867]: info: camilladsp service started and running in background, instance 1 Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:13 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:27:13 volumio volumio[867]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Dec 07 04:27:13 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 07 04:27:13 volumio sudo[7641]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:13 volumio volumio[867]: info: FusionDsp loaded Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 07 04:27:13 volumio sudo[7656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 07 04:27:13 volumio sudo[7656]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:13 volumio volumio[867]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 07 04:27:13 volumio volumio[867]: info: Adding Signal Path Element [object Object] Dec 07 04:27:13 volumio volumio[867]: info: Adding fusiondspeq DSP Signal Path Element Dec 07 04:27:13 volumio volumio[867]: info: FusionDsp - ---- installed callbackRead Dec 07 04:27:13 volumio volumio[867]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 07 04:27:13 volumio systemd[1]: Started FusionDsp Daemon. Dec 07 04:27:13 volumio sudo[7656]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:13 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:13 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:27:13 volumio volumio[867]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 07 04:27:13 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:13 volumio volumio[867]: error: FusionDsp - WebSocket error: [object Object] Dec 07 04:27:13 volumio volumio[867]: info: Executing endpoint qc_getconfig Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.384 [7651.7651] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.390 [7651.7651] INFO VolumeManager: [0x192e550]: Setting new playback volume: 75 Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.391 [7651.7651] INFO VolumeManager: [0x192e550]: Setting new mute state: 0 Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.391 [7651.7651] INFO QobuzConnect: [0x192ef20]: Client initialized! Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.391 [7651.7651] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.403 [7651.7651] INFO LocalConfigManager: [0x192de30]: Starting Local Configuration server Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.404 [7651.7651] INFO SampleApp: Starting Local configuration server Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.404 [7651.7651] INFO SampleApp: Connected to UNIX socket client 0x1923f60 Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:13 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 07 04:27:13 volumio volumio[867]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 07 04:27:13 volumio volumio[867]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 07 04:27:13 volumio volumio[867]: info: Starting Shairport Sync Dec 07 04:27:13 volumio qobuz-connect[7651]: 20251207 04:27:13.537 [7651.7651] INFO SampleApp: Playback volume changed: 75 Dec 07 04:27:13 volumio sudo[7666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 07 04:27:13 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:13 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:13 volumio sudo[7666]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:13 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 07 04:27:13 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:27:13 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 07 04:27:13 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 07 04:27:13 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:27:13 volumio volumio[7659]: Traceback (most recent call last): Dec 07 04:27:13 volumio volumio[7659]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 07 04:27:13 volumio volumio[7659]: from aiohttp import web Dec 07 04:27:13 volumio volumio[7659]: ModuleNotFoundError: No module named 'aiohttp' Dec 07 04:27:13 volumio sudo[7666]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:13 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 07 04:27:13 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 07 04:27:13 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 07 04:27:13 volumio volumio[867]: info: Shairport-Sync Started Dec 07 04:27:14 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:27:14 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:27:14 volumio volumio[867]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:27:14 volumio volumio[867]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:27:14 volumio sudo[7680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 07 04:27:14 volumio sudo[7680]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:14 volumio volumio[867]: 0+0 records in Dec 07 04:27:14 volumio volumio[867]: 0+0 records out Dec 07 04:27:14 volumio volumio[867]: 0 bytes copied, 0.000139946 s, 0.0 kB/s Dec 07 04:27:14 volumio mpd[7638]: Dec 07 04:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 07 04:27:14 volumio systemd[1]: Started Volumio Tidal Connect Service. Dec 07 04:27:14 volumio systemd[1]: Started Music Player Daemon. Dec 07 04:27:14 volumio sudo[7613]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:14 volumio sudo[7680]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:14 volumio volumio[867]: error: updateQueue error: null Dec 07 04:27:14 volumio volumio[867]: info: Executing endpoint tc_getconfig Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 07 04:27:14 volumio vtcs[7683]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 07 04:27:14 volumio vtcs[7683]: STARTED TidalConnect services. Dec 07 04:27:14 volumio volumio[867]: info: Executing endpoint tc_connect Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 07 04:27:14 volumio volumio[867]: info: Connecting to TidalConnect Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::servicePushState Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 07 04:27:14 volumio volumio[867]: verbose: CURRENT POSITION 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::syncState stateService stop Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::syncState currentStatus stop Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: No code Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::servicePushState Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 07 04:27:14 volumio volumio[867]: verbose: CURRENT POSITION 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::syncState stateService stop Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::syncState currentStatus stop Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: No code Dec 07 04:27:14 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:27:14 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:27:14 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:27:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:27:15 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 07 04:27:15 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1. Dec 07 04:27:15 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 07 04:27:15 volumio systemd[1]: Started FusionDsp Daemon. Dec 07 04:27:15 volumio volumio[7712]: Traceback (most recent call last): Dec 07 04:27:15 volumio volumio[7712]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 07 04:27:15 volumio volumio[7712]: from aiohttp import web Dec 07 04:27:15 volumio volumio[7712]: ModuleNotFoundError: No module named 'aiohttp' Dec 07 04:27:15 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 07 04:27:15 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 07 04:27:15 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:27:16 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:27:16 volumio volumio[867]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:27:16 volumio volumio[867]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:27:16 volumio sudo[7722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 07 04:27:16 volumio sudo[7722]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:16 volumio sudo[7722]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:16 volumio volumio[867]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 07 04:27:17 volumio volumio[867]: info: TidalConnect service started! Dec 07 04:27:17 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 07 04:27:17 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2. Dec 07 04:27:17 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 07 04:27:18 volumio systemd[1]: Started FusionDsp Daemon. Dec 07 04:27:18 volumio volumio[7727]: Traceback (most recent call last): Dec 07 04:27:18 volumio volumio[7727]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 07 04:27:18 volumio volumio[7727]: from aiohttp import web Dec 07 04:27:18 volumio volumio[7727]: ModuleNotFoundError: No module named 'aiohttp' Dec 07 04:27:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 07 04:27:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 07 04:27:19 volumio volumio[867]: info: TidalConnect service started! Dec 07 04:27:19 volumio volumio[867]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 07 04:27:19 volumio volumio[867]: info: FusionDsp - Stopping FusionDsp service Dec 07 04:27:19 volumio volumio[867]: info: camilladsp stopping service pid 7685... Dec 07 04:27:19 volumio volumio[867]: info: camilladsp service terminated, instance 1 Dec 07 04:27:19 volumio sudo[7745]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Dec 07 04:27:19 volumio sudo[7745]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:19 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 07 04:27:19 volumio sudo[7745]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:19 volumio volumio[867]: info: FusionDsp - Reporting Fusion DSP Disabled Dec 07 04:27:19 volumio volumio[867]: info: Removing fusiondspeq DSP Signal Path Element Dec 07 04:27:19 volumio volumio[867]: info: Check plugin dependencies Dec 07 04:27:19 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 07 04:27:19 volumio volumio[867]: info: Rename folder Dec 07 04:27:19 volumio volumio[867]: info: Folder /tmp/downloaded_plugin.zip removed Dec 07 04:27:19 volumio volumio[867]: info: Move to category Dec 07 04:27:21 volumio volumio[867]: info: Checking if install.sh is present Dec 07 04:27:21 volumio volumio[867]: info: Executing install.sh Dec 07 04:27:21 volumio sudo[7760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Dec 07 04:27:21 volumio sudo[7760]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:21 volumio volumio[867]: info: creating filters folder and copying demo filters Dec 07 04:27:21 volumio volumio[867]: info: copying demo flters Dec 07 04:27:21 volumio volumio[867]: info: ./presets/ Dec 07 04:27:21 volumio volumio[867]: info: ./presets/2XEQ15/ Dec 07 04:27:21 volumio volumio[867]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/PEQ/ Dec 07 04:27:21 volumio volumio[867]: info: ./presets/convfir/ Dec 07 04:27:21 volumio volumio[867]: info: ./presets/convfir/kef.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/convfir/test.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/EQ15/ Dec 07 04:27:21 volumio volumio[867]: info: ./presets/EQ15/.Bass-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/EQ15/.Classic-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/EQ15/.Voice-FusionDsp.json Dec 07 04:27:21 volumio volumio[867]: info: ./presets/EQ15/.Rock-FusionDsp.json Dec 07 04:27:21 volumio sudo[7785]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Dec 07 04:27:21 volumio sudo[7785]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:21 volumio volumio[867]: info: Installing/fusiondsp dependencies Dec 07 04:27:22 volumio volumio[867]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease Dec 07 04:27:22 volumio volumio[867]: info: Ign:2 http://raspbian.raspberrypi.org/raspbian buster InRelease Dec 07 04:27:22 volumio volumio[867]: info: Hit:3 http://archive.raspberrypi.org/debian buster InRelease Dec 07 04:27:23 volumio volumio[867]: info: Err:4 http://raspbian.raspberrypi.org/raspbian buster Release Dec 07 04:27:23 volumio volumio[867]: info: 404 Not Found [IP: 93.93.128.193 80] Dec 07 04:27:23 volumio volumio[867]: info: Reading package lists... Dec 07 04:27:23 volumio sudo[7785]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:23 volumio sudo[7964]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Dec 07 04:27:23 volumio sudo[7964]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:23 volumio volumio[867]: info: Reading package lists... Dec 07 04:27:23 volumio volumio[867]: info: Building dependency tree... Dec 07 04:27:23 volumio volumio[867]: info: Reading state information... Dec 07 04:27:23 volumio sudo[7964]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:23 volumio sudo[7968]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Dec 07 04:27:23 volumio sudo[7968]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:23 volumio volumio[867]: info: lib/systemd/system/fusiondsp.service Dec 07 04:27:23 volumio sudo[7968]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:24 volumio volumio[867]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Dec 07 04:27:24 volumio volumio[867]: info: more info at http://www.winimage.com/zLibDll/unzip.html Dec 07 04:27:24 volumio volumio[867]: info: Dec 07 04:27:24 volumio volumio[867]: info: cgui-1.0.0.zip opened Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/ Dec 07 04:27:24 volumio sudo[7972]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/LICENSE.txt Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/README.md Dec 07 04:27:24 volumio sudo[7972]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/build/ Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/robots.txt Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/logo512.png Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/asset-manifest.json Dec 07 04:27:24 volumio sudo[7972]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/index.html Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/.put_statics_here Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/favicon.ico Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/logo192.png Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/manifest.json Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/css-variables.css Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/service-worker.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/build/static/ Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/build/static/css/ Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/main.1503f6cd.css Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/build/static/media/ Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Dec 07 04:27:24 volumio sudo[7974]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/build/static/js/ Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Dec 07 04:27:24 volumio sudo[7974]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/main.71e11955.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Dec 07 04:27:24 volumio sudo[7974]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/main.71e11955.js.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/config/ Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/config/camillagui.yml Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/config/gui-config.yml Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/backend/ Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/filters_test.py Dec 07 04:27:24 volumio sudo[7979]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/version.py Dec 07 04:27:24 volumio sudo[7979]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/filters.py Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/settings.py Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/views.py Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/filterdefaults.py Dec 07 04:27:24 volumio sudo[7979]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__init__.py Dec 07 04:27:24 volumio volumio[867]: info: creating directory: cgui/backend/__pycache__/ Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/routes.py Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/backend/filemanagement.py Dec 07 04:27:24 volumio volumio[867]: info: extracting: cgui/main.py Dec 07 04:27:25 volumio volumio[867]: info: copying hw detection script Dec 07 04:27:25 volumio volumio[867]: info: Detected cpu architecture as armv7l Dec 07 04:27:26 volumio sudo[7992]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params Dec 07 04:27:26 volumio sudo[7992]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:26 volumio sudo[7992]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:26 volumio sudo[7994]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Dec 07 04:27:26 volumio sudo[7994]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:26 volumio sudo[7994]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:26 volumio sudo[7996]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Dec 07 04:27:26 volumio sudo[7996]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:26 volumio volumio[867]: info: Reading package lists... Dec 07 04:27:27 volumio volumio[867]: info: Building dependency tree... Dec 07 04:27:27 volumio volumio[867]: info: Reading state information... Dec 07 04:27:27 volumio sudo[7996]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:27 volumio sudo[7760]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:27 volumio volumio[867]: info: Install script completed Dec 07 04:27:27 volumio volumio[867]: info: Done installing plugin. Dec 07 04:27:27 volumio volumio[867]: info: Enabling plugin fusiondsp Dec 07 04:27:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 07 04:27:27 volumio volumio[867]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.62","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":false}] Dec 07 04:27:27 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 07 04:27:27 volumio volumio[867]: info: Folder /tmp/plugins removed Dec 07 04:27:27 volumio volumio[867]: info: Folder /tmp/downloaded_plugin.zip removed Dec 07 04:27:27 volumio volumio[867]: Plugin install end detected on script Dec 07 04:27:27 volumio volumio[867]: info: Folder /data/temp removed Dec 07 04:27:27 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 04:27:27 volumio volumio[867]: info: FusionDsp - Dec 07 04:27:27 volumio volumio[867]: info: FusionDsp - undefined Dec 07 04:27:40 volumio volumio[867]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Dec 07 04:27:42 volumio volumio[867]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/spop/volumio/buster/armhf Dec 07 04:27:42 volumio volumio[867]: info: Folder /tmp/plugins removed Dec 07 04:27:43 volumio volumio[867]: info: Check plugin dependencies Dec 07 04:27:43 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 07 04:27:43 volumio volumio[867]: info: Checking if plugin already exists Dec 07 04:27:43 volumio volumio[867]: info: Rename folder Dec 07 04:27:43 volumio volumio[867]: info: Folder /tmp/downloaded_plugin.zip removed Dec 07 04:27:43 volumio volumio[867]: info: Move to category Dec 07 04:27:45 volumio volumio[867]: info: Checking if install.sh is present Dec 07 04:27:45 volumio volumio[867]: info: Executing install.sh Dec 07 04:27:45 volumio sudo[8046]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/spop/install.sh Dec 07 04:27:45 volumio sudo[8046]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:45 volumio volumio[867]: info: Installing Go-librespot Dec 07 04:27:45 volumio volumio[867]: info: Checking old vollibrespot installs Dec 07 04:27:45 volumio systemd[1]: Reloading. Dec 07 04:27:45 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Dec 07 04:27:46 volumio volumio[867]: info: Downloading daemon Dec 07 04:27:48 volumio volumio[867]: info: Creating directories Dec 07 04:27:48 volumio volumio[867]: info: Creating data directory Dec 07 04:27:48 volumio volumio[867]: info: Creating Start Script Dec 07 04:27:48 volumio systemd[1]: Reloading. Dec 07 04:27:48 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Dec 07 04:27:49 volumio sudo[8046]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:49 volumio volumio[867]: info: Install script completed Dec 07 04:27:49 volumio volumio[867]: info: Adding reference to registry Dec 07 04:27:49 volumio volumio[867]: info: Done installing plugin. Dec 07 04:27:49 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 07 04:27:49 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 07 04:27:49 volumio volumio[867]: info: Folder /tmp/plugins removed Dec 07 04:27:49 volumio volumio[867]: info: Folder /tmp/downloaded_plugin.zip removed Dec 07 04:27:49 volumio volumio[867]: Plugin install end detected on script Dec 07 04:27:49 volumio volumio[867]: info: Folder /data/temp removed Dec 07 04:27:49 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 04:27:49 volumio volumio[867]: info: FusionDsp - Dec 07 04:27:49 volumio volumio[867]: info: FusionDsp - undefined Dec 07 04:27:50 volumio volumio[867]: info: Enabling plugin spop Dec 07 04:27:50 volumio volumio[867]: info: Loading plugin "spop"... Dec 07 04:27:51 volumio volumio[867]: info: PLUGIN START: spop Dec 07 04:27:51 volumio volumio[867]: info: Creating Spotify config file Dec 07 04:27:51 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:27:51 volumio volumio[867]: info: Done. Dec 07 04:27:51 volumio volumio[867]: info: Spotify config file written Dec 07 04:27:51 volumio volumio[867]: info: No need to fix Spotify hosts Dec 07 04:27:51 volumio sudo[8109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 07 04:27:51 volumio sudo[8109]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:27:51 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 04:27:51 volumio volumio[867]: info: FusionDsp - Dec 07 04:27:51 volumio systemd[1]: Started go-librespot Daemon. Dec 07 04:27:51 volumio go-librespot[8111]: go-librespot daemon starting... Dec 07 04:27:51 volumio sudo[8109]: pam_unix(sudo:session): session closed for user root Dec 07 04:27:51 volumio go-librespot[8111]: time="2025-12-07T04:27:51-03:00" level=info msg="running go-librespot 0.4.0" Dec 07 04:27:51 volumio go-librespot[8111]: time="2025-12-07T04:27:51-03:00" level=debug msg="no app state found" Dec 07 04:27:51 volumio go-librespot[8111]: time="2025-12-07T04:27:51-03:00" level=debug msg="stored credentials not found" Dec 07 04:27:51 volumio go-librespot[8111]: time="2025-12-07T04:27:51-03:00" level=info msg="generated new device id: 3675a2990c42b8f8fd6ed8f1cdf09eb149e5d423" Dec 07 04:27:51 volumio go-librespot[8111]: time="2025-12-07T04:27:51-03:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 07 04:27:51 volumio volumio[867]: info: FusionDsp - undefined Dec 07 04:27:52 volumio go-librespot[8111]: time="2025-12-07T04:27:52-03:00" level=debug msg="fetched new accesspoints: [ap-guc3.spotify.com:4070 ap-guc3.spotify.com:443 ap-guc3.spotify.com:80 ap-gae2.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 07 04:27:52 volumio go-librespot[8111]: time="2025-12-07T04:27:52-03:00" level=debug msg="fetched new dealers: [guc3-dealer.spotify.com:443 gae2-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 07 04:27:52 volumio go-librespot[8111]: time="2025-12-07T04:27:52-03:00" level=debug msg="fetched new spclients: [guc3-spclient.spotify.com:443 gae2-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 07 04:27:52 volumio go-librespot[8111]: time="2025-12-07T04:27:52-03:00" level=info msg="zeroconf server listening on port 32841" Dec 07 04:27:54 volumio volumio[867]: info: go-librespot daemon successfully initialized Dec 07 04:27:57 volumio volumio[867]: info: Initializing connection to go-librespot Websocket Dec 07 04:27:57 volumio go-librespot[8111]: time="2025-12-07T04:27:57-03:00" level=debug msg="new websocket client" Dec 07 04:27:57 volumio volumio[867]: info: Connection to go-librespot Websocket established Dec 07 04:28:00 volumio ntpd[730]: Soliciting pool server 2606:4700:f1::1 Dec 07 04:28:00 volumio volumio[867]: info: Getting Spotify volume Dec 07 04:28:01 volumio volumio[867]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 07 04:28:01 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:01 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:01 volumio volumio[867]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 07 04:28:01 volumio volumio[867]: SPOTIFY: SPOTIFY VOLUME undefined Dec 07 04:28:01 volumio volumio[867]: SPOTIFY: VOLUMIO VOLUME 100 Dec 07 04:28:01 volumio volumio[867]: info: Aligning Spotify Volume to Volumio Volume Dec 07 04:28:01 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:01 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:01 volumio volumio[867]: info: Setting Spotify Volume from Volumio: 100 Dec 07 04:28:02 volumio volumio[867]: SPOTIFY: SETTING SPOTIFY VOLUME 100 Dec 07 04:28:02 volumio volumio[867]: info: Sending Spotify command with payload to local API: /player/volume Dec 07 04:28:03 volumio volumio[867]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf Dec 07 04:28:05 volumio volumio[867]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpd_oled/volumio/buster/armhf Dec 07 04:28:05 volumio volumio[867]: info: Folder /tmp/plugins removed Dec 07 04:28:06 volumio volumio[867]: info: Check plugin dependencies Dec 07 04:28:06 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 07 04:28:06 volumio volumio[867]: info: Checking if plugin already exists Dec 07 04:28:06 volumio volumio[867]: info: Rename folder Dec 07 04:28:06 volumio volumio[867]: info: Folder /tmp/downloaded_plugin.zip removed Dec 07 04:28:06 volumio volumio[867]: info: Move to category Dec 07 04:28:06 volumio volumio[867]: info: Checking if install.sh is present Dec 07 04:28:06 volumio volumio[867]: info: Executing install.sh Dec 07 04:28:06 volumio sudo[8151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/system_hardware/mpd_oled/install.sh Dec 07 04:28:06 volumio sudo[8151]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:07 volumio sudo[8154]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/bash mpd_oled_volumio_install_latest.sh Dec 07 04:28:07 volumio sudo[8154]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:07 volumio volumio[867]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease Dec 07 04:28:08 volumio volumio[867]: info: Hit:2 http://archive.raspberrypi.org/debian buster InRelease Dec 07 04:28:08 volumio volumio[867]: info: Ign:3 http://raspbian.raspberrypi.org/raspbian buster InRelease Dec 07 04:28:08 volumio volumio[867]: info: Err:4 http://raspbian.raspberrypi.org/raspbian buster Release Dec 07 04:28:08 volumio volumio[867]: info: 404 Not Found [IP: 93.93.128.193 80] Dec 07 04:28:08 volumio volumio[867]: info: Reading package lists... Dec 07 04:28:08 volumio volumio[867]: info: Reading package lists... Dec 07 04:28:08 volumio volumio[867]: info: Building dependency tree... Dec 07 04:28:08 volumio volumio[867]: info: Reading state information... Dec 07 04:28:10 volumio sudo[8154]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:10 volumio sudo[8313]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/systemctl disable mpd_oled Dec 07 04:28:10 volumio sudo[8313]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:10 volumio sudo[8313]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:10 volumio systemd[1]: Reloading. Dec 07 04:28:11 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Dec 07 04:28:11 volumio systemd[1]: Reloading. Dec 07 04:28:11 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Dec 07 04:28:12 volumio volumio[867]: info: Installing i2c-tools for screen detection Dec 07 04:28:12 volumio sudo[8346]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt-get --assume-yes install i2c-tools Dec 07 04:28:12 volumio sudo[8346]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:12 volumio volumio[867]: info: Reading package lists... Dec 07 04:28:12 volumio volumio[867]: info: Building dependency tree... Dec 07 04:28:12 volumio volumio[867]: info: Reading state information... Dec 07 04:28:12 volumio volumio[867]: info: i2c-tools is already the newest version (4.1-1). Dec 07 04:28:12 volumio sudo[8346]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:12 volumio volumio[867]: info: 0 upgraded, 0 newly installed, 0 to remove and 2 not upgraded. Dec 07 04:28:12 volumio sudo[8350]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp ./cava /usr/local/bin/mpd_oled_cava Dec 07 04:28:12 volumio sudo[8350]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:12 volumio sudo[8350]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:12 volumio volumio[867]: info: Installing CAVA Dec 07 04:28:12 volumio sudo[8352]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/mkdir /usr/local/share/consolefonts Dec 07 04:28:12 volumio sudo[8352]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:12 volumio sudo[8352]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:12 volumio sudo[8354]: root : TTY=unknown ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/cp ./cava.psf /usr/local/share/consolefonts Dec 07 04:28:12 volumio sudo[8354]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:12 volumio sudo[8354]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:12 volumio volumio[867]: info: Checking I2C busses Dec 07 04:28:12 volumio volumio[867]: info: * I2C-1 bus enabled Dec 07 04:28:12 volumio volumio[867]: info: * I2C-0 bus enabled Dec 07 04:28:12 volumio sudo[8151]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:12 volumio volumio[867]: info: Install script completed Dec 07 04:28:12 volumio volumio[867]: info: Adding reference to registry Dec 07 04:28:12 volumio volumio[867]: info: Done installing plugin. Dec 07 04:28:12 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 07 04:28:12 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 07 04:28:12 volumio volumio[867]: info: Folder /tmp/plugins removed Dec 07 04:28:12 volumio volumio[867]: info: Folder /tmp/downloaded_plugin.zip removed Dec 07 04:28:12 volumio volumio[867]: info: Setting I2C baudrate Dec 07 04:28:12 volumio volumio[867]: info: Enabling SPI Dec 07 04:28:12 volumio volumio[867]: Plugin install end detected on script Dec 07 04:28:12 volumio volumio[867]: info: Folder /data/temp removed Dec 07 04:28:12 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 04:28:12 volumio volumio[867]: info: FusionDsp - Dec 07 04:28:12 volumio volumio[867]: info: FusionDsp - undefined Dec 07 04:28:14 volumio volumio[867]: info: Enabling plugin mpd_oled Dec 07 04:28:14 volumio volumio[867]: info: Loading plugin "mpd_oled"... Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of OLED_TYPE to Escoja... Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of NUMBER_OF_BARS to 16 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of GAP_BETWEEN_BARS to 1 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of FRAME_RATE to 50 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of SCROLL_RATE to 8 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of SCROLL_DELAY to 5 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of CLOCK_FORMAT to 24h con 0 inicial (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of PAUSE_SCREEN_TYPE to Reproduccion (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of INVERT_DISPLAY_PERIOD to Deshabilitado (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of I2C_ADDRESS to Valor por defecto de la pantalla Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of I2C_BUS to /dev/i2c-1 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of SPI_RESET_GPIO_NUMBER to 25 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of SPI_DC_GPIO_NUMBER to 24 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of SPI_CS to 0 (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Translated default label of DATE_FORMAT to DD-MM-YYYY (por defecto) Dec 07 04:28:14 volumio volumio[867]: info: Preparing to generate the ALSA configuration file Dec 07 04:28:14 volumio volumio[867]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 07 04:28:14 volumio volumio[867]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 07 04:28:14 volumio volumio[867]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 07 04:28:14 volumio volumio[867]: info: Reading ALSA contributions from plugins. Dec 07 04:28:14 volumio volumio[867]: info: Asound.conf file written Dec 07 04:28:14 volumio sudo[8363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 07 04:28:14 volumio sudo[8363]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio sudo[8363]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:14 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:28:14 volumio volumio[867]: No state is present for card b1 Dec 07 04:28:14 volumio volumio[867]: /usr/share/alsa/init/bcm2835:14: control element not found Dec 07 04:28:14 volumio volumio[867]: No state is present for card b1 Dec 07 04:28:14 volumio volumio[867]: No state is present for card Headphones Dec 07 04:28:14 volumio volumio[867]: /usr/share/alsa/init/bcm2835:20: control element not found Dec 07 04:28:14 volumio volumio[867]: No state is present for card Headphones Dec 07 04:28:14 volumio volumio[867]: No state is present for card IQaudIODAC Dec 07 04:28:14 volumio volumio[867]: Found hardware: "IQaudIODAC" "" "" "" "" Dec 07 04:28:14 volumio volumio[867]: Hardware is initialized using a generic method Dec 07 04:28:14 volumio volumio[867]: No state is present for card IQaudIODAC Dec 07 04:28:14 volumio volumio[867]: info: Output device has changed, restarting MPD Dec 07 04:28:14 volumio sudo[8368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 07 04:28:14 volumio sudo[8368]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio sudo[8368]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:14 volumio volumio[867]: info: Output device has changed, restarting Shairport Sync Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:28:14 volumio sudo[8371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 07 04:28:14 volumio sudo[8371]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio systemd[1]: Stopping Music Player Daemon... Dec 07 04:28:14 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:28:14 volumio volumio[867]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 07 04:28:14 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:28:14 volumio systemd[1]: mpd.service: Succeeded. Dec 07 04:28:14 volumio systemd[1]: Stopped Music Player Daemon. Dec 07 04:28:14 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:14 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:14 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:14 volumio vtcs[7683]: [2025-12-07 04:28:14.571] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 07 04:28:14 volumio vtcs[7683]: [2025-12-07 04:28:14.572] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer Dec 07 04:28:14 volumio vtcs[7683]: [2025-12-07 04:28:14.572] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 07 04:28:14 volumio systemd[1]: Starting Music Player Daemon... Dec 07 04:28:14 volumio volumio[867]: info: PLUGIN START: mpd_oled Dec 07 04:28:14 volumio sudo[8380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:28:14 volumio sudo[8380]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 07 04:28:14 volumio volumio[867]: info: [MPD_OLED Plugin] Not starting mpd_oled service because oled type is not configured yet Dec 07 04:28:14 volumio volumio[867]: info: Preparing to generate the ALSA configuration file Dec 07 04:28:14 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Dec 07 04:28:14 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 07 04:28:14 volumio systemd[1]: vtcs.service: Succeeded. Dec 07 04:28:14 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Dec 07 04:28:14 volumio volumio[867]: info: Done. Dec 07 04:28:14 volumio sudo[8380]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:14 volumio sudo[8376]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 07 04:28:14 volumio sudo[8386]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:28:14 volumio sudo[8386]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio sudo[8376]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio sudo[8376]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:14 volumio volumio[867]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 07 04:28:14 volumio volumio[867]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 07 04:28:14 volumio volumio[867]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Dec 07 04:28:14 volumio volumio[867]: info: Reading ALSA contributions from plugins. Dec 07 04:28:14 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:14 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:28:14 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:14 volumio sudo[8394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 07 04:28:14 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:14 volumio volumio[867]: info: MPD Permissions set Dec 07 04:28:14 volumio sudo[8394]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 07 04:28:14 volumio sudo[8394]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:14 volumio sudo[8386]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:14 volumio sudo[8396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 07 04:28:14 volumio sudo[8396]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:28:14 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:14 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 07 04:28:14 volumio qobuz-connect[7651]: 20251207 04:28:14.872 [7651.7651] INFO SampleApp: Stopping Local configuration server Dec 07 04:28:14 volumio volumio[867]: info: FusionDsp - Dec 07 04:28:14 volumio qobuz-connect[7651]: 20251207 04:28:14.882 [7651.7651] INFO SampleApp: shat down connection on UNIX socket Dec 07 04:28:14 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 07 04:28:14 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 07 04:28:14 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 07 04:28:14 volumio sudo[8396]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:28:15 volumio volumio[867]: info: Starting Shairport Sync Dec 07 04:28:15 volumio volumio[867]: info: FusionDsp - undefined Dec 07 04:28:15 volumio sudo[8406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 07 04:28:15 volumio sudo[8406]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 07 04:28:15 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 07 04:28:15 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 07 04:28:15 volumio volumio[867]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 07 04:28:15 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:15 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:28:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 07 04:28:15 volumio sudo[8406]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio volumio[867]: info: Executing endpoint qc_getconfig Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.434 [8403.8403] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 07 04:28:15 volumio volumio[867]: info: Asound.conf file unchanged, so no further update is needed Dec 07 04:28:15 volumio volumio[867]: info: Output device has changed, restarting MPD Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.441 [8403.8403] INFO VolumeManager: [0x157b550]: Setting new playback volume: 75 Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.441 [8403.8403] INFO VolumeManager: [0x157b550]: Setting new mute state: 0 Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.441 [8403.8403] INFO QobuzConnect: [0x157bf20]: Client initialized! Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.441 [8403.8403] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.454 [8403.8403] INFO LocalConfigManager: [0x157ae30]: Starting Local Configuration server Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.454 [8403.8403] INFO SampleApp: Starting Local configuration server Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.455 [8403.8403] INFO SampleApp: Connected to UNIX socket client 0x1570f60 Dec 07 04:28:15 volumio sudo[8414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 07 04:28:15 volumio sudo[8414]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio volumio[867]: info: Output device has changed, restarting Shairport Sync Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:28:15 volumio sudo[8414]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio sudo[8417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 07 04:28:15 volumio sudo[8417]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 07 04:28:15 volumio systemd[1]: mpd.service: Succeeded. Dec 07 04:28:15 volumio systemd[1]: Stopped Music Player Daemon. Dec 07 04:28:15 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:28:15 volumio volumio[867]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 07 04:28:15 volumio volumio[867]: xcb_connection_has_error() returned true Dec 07 04:28:15 volumio volumio[867]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.584 [8403.8403] INFO SampleApp: Playback volume changed: 75 Dec 07 04:28:15 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:15 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:15 volumio systemd[1]: Starting Music Player Daemon... Dec 07 04:28:15 volumio sudo[8426]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:28:15 volumio sudo[8426]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio sudo[8429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 07 04:28:15 volumio sudo[8429]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio sudo[8426]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio sudo[8429]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:15 volumio sudo[8437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 07 04:28:15 volumio sudo[8437]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio sudo[8422]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 07 04:28:15 volumio volumio[867]: info: Shairport-Sync Started Dec 07 04:28:15 volumio sudo[8422]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio sudo[8422]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio volumio[867]: (node:867) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 07 04:28:15 volumio volumio[867]: (Use `node --trace-warnings ...` to show where the warning was created) Dec 07 04:28:15 volumio volumio[867]: (node:867) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 07 04:28:15 volumio volumio[867]: (node:867) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 07 04:28:15 volumio volumio[867]: (node:867) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 07 04:28:15 volumio volumio[867]: (node:867) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit Dec 07 04:28:15 volumio volumio[867]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 07 04:28:15 volumio volumio[867]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 07 04:28:15 volumio volumio[867]: info: MPD Permissions set Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:15 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 07 04:28:15 volumio volumio[867]: info: Starting Shairport Sync Dec 07 04:28:15 volumio sudo[8446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 07 04:28:15 volumio sudo[8446]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio sudo[8437]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio sudo[8448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 07 04:28:15 volumio sudo[8448]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:15 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 07 04:28:15 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 07 04:28:15 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:15 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:28:15 volumio sudo[8446]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:15 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.942 [8403.8403] INFO SampleApp: Stopping Local configuration server Dec 07 04:28:15 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 07 04:28:15 volumio qobuz-connect[8403]: 20251207 04:28:15.953 [8403.8403] INFO SampleApp: shat down connection on UNIX socket Dec 07 04:28:15 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 07 04:28:15 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 07 04:28:15 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 07 04:28:15 volumio sudo[8448]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:16 volumio volumio[867]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 07 04:28:16 volumio volumio[867]: info: Shairport-Sync Started Dec 07 04:28:16 volumio volumio[867]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 07 04:28:16 volumio volumio[867]: info: QobuzConnect: setDeactiveState invoked Dec 07 04:28:16 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:16 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:16 volumio volumio[867]: info: Executing endpoint qc_getconfig Dec 07 04:28:16 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.050 [8452.8452] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 07 04:28:16 volumio volumio[867]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 07 04:28:16 volumio volumio[867]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.056 [8452.8452] INFO VolumeManager: [0x1b35550]: Setting new playback volume: 75 Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.056 [8452.8452] INFO VolumeManager: [0x1b35550]: Setting new mute state: 0 Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.056 [8452.8452] INFO QobuzConnect: [0x1b35f20]: Client initialized! Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.057 [8452.8452] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.068 [8452.8452] INFO LocalConfigManager: [0x1b34e30]: Starting Local Configuration server Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.068 [8452.8452] INFO SampleApp: Starting Local configuration server Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.069 [8452.8452] INFO SampleApp: Connected to UNIX socket client 0x1b2af60 Dec 07 04:28:16 volumio qobuz-connect[8452]: 20251207 04:28:16.200 [8452.8452] INFO SampleApp: Playback volume changed: 75 Dec 07 04:28:16 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:16 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:17 volumio mpd[8440]: Dec 07 04:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 07 04:28:17 volumio systemd[1]: Started Music Player Daemon. Dec 07 04:28:17 volumio sudo[8371]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:17 volumio sudo[8417]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:17 volumio volumio[867]: error: MPD error: The expression evaluated to a falsy value: Dec 07 04:28:17 volumio volumio[867]: assert.ok(self.idling) Dec 07 04:28:17 volumio volumio[867]: error: The expression evaluated to a falsy value: Dec 07 04:28:17 volumio volumio[867]: assert.ok(self.idling) Dec 07 04:28:17 volumio volumio[867]: error: updateQueue error: null Dec 07 04:28:17 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:28:17 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:28:17 volumio volumio[867]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:28:17 volumio volumio[867]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:28:17 volumio sudo[8467]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 07 04:28:17 volumio sudo[8467]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:17 volumio systemd[1]: Started Volumio Tidal Connect Service. Dec 07 04:28:18 volumio sudo[8467]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:18 volumio volumio[867]: info: Executing endpoint tc_getconfig Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 07 04:28:18 volumio vtcs[8469]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 07 04:28:18 volumio vtcs[8469]: STARTED TidalConnect services. Dec 07 04:28:18 volumio volumio[867]: info: Executing endpoint tc_connect Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 07 04:28:18 volumio volumio[867]: info: Connecting to TidalConnect Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::servicePushState Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 07 04:28:18 volumio volumio[867]: verbose: CURRENT POSITION 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::syncState stateService stop Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::syncState currentStatus stop Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: No code Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::servicePushState Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Dec 07 04:28:18 volumio volumio[867]: verbose: CURRENT POSITION 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::syncState stateService stop Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::syncState currentStatus stop Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: No code Dec 07 04:28:18 volumio volumio[867]: info: CoreStateMachine::pushState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioPushState Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output update for this device Dec 07 04:28:18 volumio volumio[867]: info: MRS: Pushing multiroomSync output Dec 07 04:28:18 volumio volumio[867]: info: CoreCommandRouter::volumioGetState Dec 07 04:28:18 volumio volumio[867]: info: CorePlayQueue::getTrack 0 Dec 07 04:28:18 volumio volumio[867]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 07 04:28:18 volumio volumio[867]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 07 04:28:18 volumio volumio[867]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 07 04:28:18 volumio volumio[867]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 07 04:28:18 volumio volumio[867]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 07 04:28:18 volumio volumio[867]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 07 04:28:18 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:28:18 volumio volumio[867]: info: TidalConnect service stoped! Dec 07 04:28:18 volumio volumio[867]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:28:18 volumio volumio[867]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 07 04:28:18 volumio sudo[8511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 07 04:28:18 volumio sudo[8511]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 07 04:28:18 volumio sudo[8511]: pam_unix(sudo:session): session closed for user root Dec 07 04:28:18 volumio volumio[867]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 07 04:28:21 volumio volumio[867]: info: TidalConnect service started! Dec 07 04:28:21 volumio volumio[867]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 07 04:28:21 volumio volumio[867]: info: FusionDsp - Stopping FusionDsp service Dec 07 04:28:21 volumio volumio[867]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 04:28:21 volumio volumio[867]: TypeError: Cannot read property 'stop' of null Dec 07 04:28:21 volumio volumio[867]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Dec 07 04:28:21 volumio volumio[867]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Dec 07 04:28:21 volumio volumio[867]: at /volumio/app/pluginmanager.js:956:12 Dec 07 04:28:21 volumio volumio[867]: at ChildProcess.exithandler (child_process.js:299:7) Dec 07 04:28:21 volumio volumio[867]: at ChildProcess.emit (events.js:315:20) Dec 07 04:28:21 volumio volumio[867]: at maybeClose (internal/child_process.js:1048:16) Dec 07 04:28:21 volumio volumio[867]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) Dec 07 04:28:21 volumio volumio[867]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 07 04:28:22 volumio sudo[8542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-07 04:27 Dec 07 04:28:22 volumio sudo[8542]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"