-- Logs begin at Tue 2025-10-28 20:42:45 -03, end at Tue 2025-10-28 21:13:09 -03. -- Oct 28 21:12:03 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:07 volumiolg volumio[1153]: info: Checking if install.sh is present Oct 28 21:12:07 volumiolg volumio[1153]: info: Executing install.sh Oct 28 21:12:07 volumiolg volumio[1153]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 28 21:12:07 volumiolg sudo[16403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Oct 28 21:12:07 volumiolg sudo[16403]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:07 volumiolg volumio[1153]: info: creating filters folder and copying demo filters Oct 28 21:12:07 volumiolg volumio[1153]: info: copying demo flters Oct 28 21:12:08 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:08 volumiolg volumio[1153]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Oct 28 21:12:08 volumiolg volumio[1153]: info: CoreCommandRouter::volumioGetState Oct 28 21:12:09 volumiolg volumio[1153]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Oct 28 21:12:09 volumiolg volumio[1153]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::volumioGetVisibleSources Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::volumioGetState Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::volumioGetState Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 28 21:12:09 volumiolg volumio[1153]: info: Received Get System Info Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 28 21:12:09 volumiolg volumio[1153]: info: Discovery: Getting this device information Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::volumioGetState Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::volumioGetState Oct 28 21:12:09 volumiolg volumio[1153]: info: Listing playlists Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 28 21:12:09 volumiolg volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 28 21:12:09 volumiolg volumio[1153]: info: FusionDsp - no preset used Oct 28 21:12:09 volumiolg volumio[1153]: info: FusionDsp - Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/ Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/2XEQ15/ Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/PEQ/ Oct 28 21:12:12 volumiolg sudo[16443]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Oct 28 21:12:12 volumiolg sudo[16443]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/convfir/ Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/convfir/kef.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/convfir/test.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/EQ15/ Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/EQ15/.Bass-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/EQ15/.Classic-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/EQ15/.Voice-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: ./presets/EQ15/.Rock-FusionDsp.json Oct 28 21:12:12 volumiolg volumio[1153]: info: Installing/fusiondsp dependencies Oct 28 21:12:12 volumiolg volumio[1153]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease Oct 28 21:12:12 volumiolg volumio[1153]: info: Hit:2 http://archive.debian.org/debian buster InRelease Oct 28 21:12:13 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:15 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 28 21:12:18 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:18 volumiolg volumio[1153]: info: Reading package lists... Oct 28 21:12:19 volumiolg volumio[1153]: info: Building dependency tree... Oct 28 21:12:19 volumiolg volumio[1153]: info: Reading state information... Oct 28 21:12:19 volumiolg volumio[1153]: info: All packages are up to date. Oct 28 21:12:19 volumiolg sudo[16443]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:19 volumiolg sudo[16655]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Oct 28 21:12:19 volumiolg sudo[16655]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:19 volumiolg volumio[1153]: info: Reading package lists... Oct 28 21:12:19 volumiolg volumio[1153]: info: Building dependency tree... Oct 28 21:12:19 volumiolg volumio[1153]: info: Reading state information... Oct 28 21:12:20 volumiolg volumio[1153]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1). Oct 28 21:12:20 volumiolg sudo[16655]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:20 volumiolg volumio[1153]: info: python3-pip is already the newest version (18.1-5). Oct 28 21:12:20 volumiolg volumio[1153]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Oct 28 21:12:20 volumiolg sudo[16673]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Oct 28 21:12:20 volumiolg sudo[16673]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:20 volumiolg volumio[1153]: info: lib/systemd/system/fusiondsp.service Oct 28 21:12:20 volumiolg sudo[16673]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:21 volumiolg volumio[1153]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Oct 28 21:12:21 volumiolg volumio[1153]: info: more info at http://www.winimage.com/zLibDll/unzip.html Oct 28 21:12:21 volumiolg volumio[1153]: info: Oct 28 21:12:21 volumiolg volumio[1153]: info: Cannot open cgui-1.0.0.zip or cgui-1.0.0.zip.zip Oct 28 21:12:21 volumiolg sudo[16677]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Oct 28 21:12:21 volumiolg sudo[16677]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:21 volumiolg sudo[16677]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:21 volumiolg sudo[16679]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Oct 28 21:12:21 volumiolg sudo[16679]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:21 volumiolg sudo[16679]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:21 volumiolg sudo[16681]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Oct 28 21:12:21 volumiolg sudo[16681]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:21 volumiolg sudo[16681]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:23 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:24 volumiolg volumio[1153]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Oct 28 21:12:24 volumiolg volumio[1153]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-cu2iojpn Oct 28 21:12:24 volumiolg go-librespot[1653]: time="2025-10-28T21:12:24-03:00" level=trace msg="sent dealer ping" Oct 28 21:12:24 volumiolg go-librespot[1653]: time="2025-10-28T21:12:24-03:00" level=trace msg="received dealer pong" Oct 28 21:12:26 volumiolg volumio[1153]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp==1.0.0 from git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 in /usr/local/lib/python3.7/dist-packages Oct 28 21:12:26 volumiolg volumio[1153]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0.1) Oct 28 21:12:26 volumiolg volumio[1153]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.6.1) Oct 28 21:12:26 volumiolg volumio[1153]: info: Building wheels for collected packages: camilladsp Oct 28 21:12:26 volumiolg volumio[1153]: info: Running setup.py bdist_wheel for camilladsp: started Oct 28 21:12:26 volumiolg volumio[1153]: info: Running setup.py bdist_wheel for camilladsp: finished with status 'done' Oct 28 21:12:26 volumiolg volumio[1153]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-6eps3ogx/wheels/ca/47/7d/ee36beb671f74869a8e2ecb2c3fd4a28c1b7488a9c78e442b6 Oct 28 21:12:26 volumiolg volumio[1153]: info: Successfully built camilladsp Oct 28 21:12:28 volumiolg volumio[1153]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Oct 28 21:12:28 volumiolg volumio[1153]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-9nhin5bh Oct 28 21:12:28 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp-plot==1.0.2 from git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 in /usr/local/lib/python3.7/dist-packages Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: typing-extensions; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (4.7.1) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (0.19.3) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: importlib-metadata; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (6.7.0) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: importlib-resources>=1.4.0; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (5.12.0) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: pkgutil-resolve-name>=1.3.10; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (1.3.10) Oct 28 21:12:29 volumiolg volumio[1153]: info: Requirement already satisfied: zipp>=0.5 in /usr/local/lib/python3.7/dist-packages (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) (3.15.0) Oct 28 21:12:29 volumiolg volumio[1153]: info: Building wheels for collected packages: camilladsp-plot Oct 28 21:12:29 volumiolg volumio[1153]: info: Running setup.py bdist_wheel for camilladsp-plot: started Oct 28 21:12:29 volumiolg volumio[1153]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Oct 28 21:12:29 volumiolg volumio[1153]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-ckn31jf_/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Oct 28 21:12:29 volumiolg volumio[1153]: info: Successfully built camilladsp-plot Oct 28 21:12:30 volumiolg volumio[1153]: info: copying hw detection script Oct 28 21:12:30 volumiolg volumio[1153]: info: Detected cpu architecture as x86_64 Oct 28 21:12:31 volumiolg sudo[16758]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Oct 28 21:12:31 volumiolg sudo[16758]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:12:31 volumiolg volumio[1153]: info: Reading package lists... Oct 28 21:12:31 volumiolg volumio[1153]: info: Building dependency tree... Oct 28 21:12:31 volumiolg volumio[1153]: info: Reading state information... Oct 28 21:12:32 volumiolg volumio[1153]: info: drc is already the newest version (3.2.2~dfsg0-2). Oct 28 21:12:32 volumiolg sudo[16758]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:32 volumiolg sudo[16403]: pam_unix(sudo:session): session closed for user root Oct 28 21:12:32 volumiolg volumio[1153]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Oct 28 21:12:32 volumiolg volumio[1153]: info: Install script completed Oct 28 21:12:32 volumiolg volumio[1153]: info: Done installing plugin. Oct 28 21:12:32 volumiolg volumio[1153]: info: Enabling plugin fusiondsp Oct 28 21:12:32 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 28 21:12:32 volumiolg volumio[1153]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.62","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true}] Oct 28 21:12:32 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 28 21:12:32 volumiolg volumio[1153]: info: Folder /tmp/plugins removed Oct 28 21:12:32 volumiolg volumio[1153]: info: Folder /tmp/downloaded_plugin.zip removed Oct 28 21:12:32 volumiolg volumio[1153]: Plugin install end detected on script Oct 28 21:12:32 volumiolg volumio[1153]: info: Folder /data/temp removed Oct 28 21:12:33 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:38 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:44 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:49 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:54 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:12:54 volumiolg go-librespot[1653]: time="2025-10-28T21:12:54-03:00" level=trace msg="sent dealer ping" Oct 28 21:12:54 volumiolg go-librespot[1653]: time="2025-10-28T21:12:54-03:00" level=trace msg="received dealer pong" Oct 28 21:12:59 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:13:02 volumiolg volumio[1153]: info: Enabling plugin fusiondsp Oct 28 21:13:02 volumiolg volumio[1153]: info: Loading plugin "fusiondsp"... Oct 28 21:13:02 volumiolg volumio[1153]: info: Applying required configuration parameters for plugin fusiondsp Oct 28 21:13:02 volumiolg volumio[1153]: info: Preparing to generate the ALSA configuration file Oct 28 21:13:02 volumiolg volumio[1153]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 28 21:13:02 volumiolg volumio[1153]: info: Reading ALSA contributions from plugins. Oct 28 21:13:02 volumiolg volumio[1153]: info: Asound.conf file unchanged, so no further update is needed Oct 28 21:13:02 volumiolg volumio[1153]: info: Output device has changed, restarting MPD Oct 28 21:13:02 volumiolg sudo[16871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 28 21:13:02 volumiolg sudo[16871]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg sudo[16871]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg volumio[1153]: info: Output device has changed, restarting Shairport Sync Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:02 volumiolg sudo[16874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 28 21:13:02 volumiolg sudo[16874]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg systemd[1]: Stopping Music Player Daemon... Oct 28 21:13:02 volumiolg volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 28 21:13:02 volumiolg volumio[1153]: info: PLUGIN START: fusiondsp Oct 28 21:13:02 volumiolg systemd[1]: mpd.service: Succeeded. Oct 28 21:13:02 volumiolg systemd[1]: Stopped Music Player Daemon. Oct 28 21:13:02 volumiolg volumio[1153]: info: Loading i18n strings for locale pt Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: FusionDsp - mixtype--------------------- None Oct 28 21:13:02 volumiolg volumio[1153]: info: Preparing to generate the ALSA configuration file Oct 28 21:13:02 volumiolg volumio[1153]: info: Done. Oct 28 21:13:02 volumiolg volumio[1153]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 28 21:13:02 volumiolg volumio[1153]: info: Reading ALSA contributions from plugins. Oct 28 21:13:02 volumiolg volumio[1153]: info: MPD Permissions set Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg systemd[1]: Starting Music Player Daemon... Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 28 21:13:02 volumiolg volumio[1153]: info: Starting Shairport Sync Oct 28 21:13:02 volumiolg sudo[16880]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 28 21:13:02 volumiolg sudo[16880]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg volumio[1153]: info: FusionDsp - no preset used Oct 28 21:13:02 volumiolg sudo[16880]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg sudo[16888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 28 21:13:02 volumiolg sudo[16888]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 28 21:13:02 volumiolg systemd[1]: shairport-sync.service: Succeeded. Oct 28 21:13:02 volumiolg systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:02 volumiolg systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:02 volumiolg sudo[16888]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg volumio[1153]: info: Asound.conf file unchanged, so no further update is needed Oct 28 21:13:02 volumiolg volumio[1153]: info: Output device has changed, restarting MPD Oct 28 21:13:02 volumiolg sudo[16896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 28 21:13:02 volumiolg sudo[16896]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg volumio[1153]: info: Output device has changed, restarting Shairport Sync Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg sudo[16896]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:02 volumiolg sudo[16899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 28 21:13:02 volumiolg sudo[16899]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 28 21:13:02 volumiolg systemd[1]: mpd.service: Succeeded. Oct 28 21:13:02 volumiolg systemd[1]: Stopped Music Player Daemon. Oct 28 21:13:02 volumiolg volumio[1153]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 28 21:13:02 volumiolg volumio[1153]: info: FusionDsp - Oct 28 21:13:02 volumiolg systemd[1]: Starting Music Player Daemon... Oct 28 21:13:02 volumiolg volumio[1153]: info: MPD Permissions set Oct 28 21:13:02 volumiolg volumio[1153]: info: Shairport-Sync Started Oct 28 21:13:02 volumiolg sudo[16904]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg sudo[16904]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg sudo[16904]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 28 21:13:02 volumiolg volumio[1153]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:02 volumiolg volumio[1153]: info: Starting Shairport Sync Oct 28 21:13:02 volumiolg sudo[16914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 28 21:13:02 volumiolg sudo[16914]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:02 volumiolg systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 28 21:13:02 volumiolg systemd[1]: shairport-sync.service: Succeeded. Oct 28 21:13:02 volumiolg systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:02 volumiolg systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:02 volumiolg sudo[16914]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg volumio[1153]: info: Shairport-Sync Started Oct 28 21:13:02 volumiolg mpd[16907]: Oct 28 21:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 28 21:13:02 volumiolg systemd[1]: Started Music Player Daemon. Oct 28 21:13:02 volumiolg sudo[16874]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg sudo[16899]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:02 volumiolg volumio[1153]: error: MPD error: The expression evaluated to a falsy value: Oct 28 21:13:02 volumiolg volumio[1153]: assert.ok(self.idling) Oct 28 21:13:02 volumiolg volumio[1153]: error: The expression evaluated to a falsy value: Oct 28 21:13:02 volumiolg volumio[1153]: assert.ok(self.idling) Oct 28 21:13:02 volumiolg volumio[1153]: error: updateQueue error: null Oct 28 21:13:03 volumiolg volumio[1153]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 21:13:03 volumiolg volumio[1153]: TypeError: Cannot read property 'off' of undefined Oct 28 21:13:03 volumiolg volumio[1153]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Oct 28 21:13:03 volumiolg volumio[1153]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Oct 28 21:13:03 volumiolg volumio[1153]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Oct 28 21:13:03 volumiolg volumio[1153]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Oct 28 21:13:03 volumiolg volumio[1153]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Oct 28 21:13:03 volumiolg volumio[1153]: at Socket.emit (events.js:400:28) Oct 28 21:13:03 volumiolg volumio[1153]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Oct 28 21:13:03 volumiolg volumio[1153]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Oct 28 21:13:03 volumiolg volumio[1153]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 21:13:03 volumiolg sudo[16931]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-28 21:12 Oct 28 21:13:03 volumiolg sudo[16931]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:03 volumiolg sudo[16931]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:04 volumiolg volumio-remote-updater[760]: [2025-10-28 21:13:04] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Oct 28 21:13:04 volumiolg volumio-remote-updater[760]: [2025-10-28 21:13:04] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Oct 28 21:13:04 volumiolg go-librespot[1653]: time="2025-10-28T21:13:04-03:00" level=error msg="websocket connection errored" error="failed to get reader: failed to read frame header: EOF" Oct 28 21:13:04 volumiolg systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Oct 28 21:13:04 volumiolg systemd[1]: volumio.service: Failed with result 'exit-code'. Oct 28 21:13:04 volumiolg systemd[1]: Started dynamicswap service. Oct 28 21:13:04 volumiolg systemd[1]: dynamicswap.service: Succeeded. Oct 28 21:13:04 volumiolg systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Oct 28 21:13:04 volumiolg systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Oct 28 21:13:04 volumiolg systemd[1]: Started dynamicswap service. Oct 28 21:13:04 volumiolg systemd[1]: Stopped Volumio Backend Module. Oct 28 21:13:04 volumiolg systemd[1]: Started Volumio Backend Module. Oct 28 21:13:04 volumiolg systemd[1]: dynamicswap.service: Succeeded. Oct 28 21:13:04 volumiolg kernel: intel ips 0000:00:1f.6: failed to disable graphics turbo Oct 28 21:13:04 volumiolg volumio[16945]: info: ------------------------------------------- Oct 28 21:13:04 volumiolg volumio[16945]: info: ----- Volumio3 ---- Oct 28 21:13:04 volumiolg volumio[16945]: info: ------------------------------------------- Oct 28 21:13:04 volumiolg volumio[16945]: info: ----- System startup ---- Oct 28 21:13:04 volumiolg volumio[16945]: info: ------------------------------------------- Oct 28 21:13:05 volumiolg volumio[16945]: info: MYVOLUMIO Environment detected Oct 28 21:13:05 volumiolg volumio[16945]: info: Plugin folders cleanup Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning into folder /volumio/app/plugins/ Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category audio_interface Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category miscellanea Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category music_service Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category plugins.json Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category system_controller Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category user_interface Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning into folder /data/plugins/ Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category audio_interface Oct 28 21:13:05 volumiolg volumio[16945]: info: Scanning category music_service Oct 28 21:13:05 volumiolg volumio[16945]: info: Plugin folders cleanup completed Oct 28 21:13:05 volumiolg volumio[16945]: info: ------------------------------------------- Oct 28 21:13:05 volumiolg volumio[16945]: info: ----- Core plugins startup ---- Oct 28 21:13:05 volumiolg volumio[16945]: info: ------------------------------------------- Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugins from folder /volumio/app/plugins/ Oct 28 21:13:05 volumiolg volumio[16945]: info: Adding plugin upnp to MyMusic Plugins Oct 28 21:13:05 volumiolg volumio[16945]: info: Adding plugin airplay_emulation to MyMusic Plugins Oct 28 21:13:05 volumiolg volumio[16945]: info: Adding plugin upnp_browser to MyMusic Plugins Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugins from folder /data/plugins/ Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "system"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "appearance"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "network"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Refreshing Cached IP Addresses Oct 28 21:13:05 volumiolg sudo[16972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 28 21:13:05 volumiolg sudo[16972]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:05 volumiolg sudo[16972]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:05 volumiolg sudo[16974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 28 21:13:05 volumiolg sudo[16974]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:05 volumiolg sudo[16974]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "services"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "alsa_controller"... Oct 28 21:13:05 volumiolg sudo[16986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 28 21:13:05 volumiolg sudo[16986]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:05 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "wizard"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "networkfs"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Starting Udev Watcher for removable devices Oct 28 21:13:05 volumiolg sudo[16998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=3.11 //192.168.0.200/Musica/acsetz@gmail.com /mnt/NAS/MyCloud Oct 28 21:13:05 volumiolg sudo[16998]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:05 volumiolg volumio[16945]: info: Ignoring mount for partition: boot Oct 28 21:13:05 volumiolg volumio[16945]: info: Ignoring mount for partition: volumio Oct 28 21:13:05 volumiolg volumio[16945]: info: Ignoring mount for partition: volumio_data Oct 28 21:13:05 volumiolg kernel: CIFS: Attempting to mount //192.168.0.200/Musica/acsetz@gmail.com Oct 28 21:13:05 volumiolg volumio[16945]: info: Ignoring mount for partition: 5EBD3CE729A5EF05 Oct 28 21:13:05 volumiolg volumio[16945]: info: Ignoring mount for partition: 5ECD-16AA Oct 28 21:13:05 volumiolg volumio[16945]: error: Cannot associate FS Label, not mounting Oct 28 21:13:05 volumiolg volumio[16945]: info: Ignoring mount for partition: 784b394d-f94e-481f-aeee-98ab580d6be0 Oct 28 21:13:05 volumiolg volumio[16945]: info: Ignoring mount for partition: 7c7b5977-0ce9-47cf-98a1-40e63ef0d80c Oct 28 21:13:05 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "volumio_command_line_client"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "upnp"... Oct 28 21:13:05 volumiolg volumio[16945]: info: [1761696785666] Starting Upmpd Daemon Oct 28 21:13:05 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "my_music"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "mpd"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "upnp_browser"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "alarm-clock"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "airplay_emulation"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Starting Shairport Sync Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "last_100"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "webradio"... Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "i2s_dacs"... Oct 28 21:13:05 volumiolg volumio[16945]: info: I2S DAC not set, start Auto-detection Oct 28 21:13:05 volumiolg volumio[16945]: info: Loading plugin "volumiodiscovery"... Oct 28 21:13:05 volumiolg volumio[16945]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 28 21:13:05 volumiolg volumio[16945]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 28 21:13:05 volumiolg volumio[16945]: *** WARNING *** For more information see Oct 28 21:13:05 volumiolg volumio[16945]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 28 21:13:05 volumiolg volumio[16945]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 28 21:13:05 volumiolg volumio[16945]: *** WARNING *** For more information see Oct 28 21:13:05 volumiolg node[16945]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Oct 28 21:13:05 volumiolg node[16945]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 28 21:13:05 volumiolg node[16945]: *** WARNING *** For more information see Oct 28 21:13:05 volumiolg node[16945]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Oct 28 21:13:05 volumiolg node[16945]: *** WARNING *** Please fix your application to use the native API of Avahi! Oct 28 21:13:05 volumiolg node[16945]: *** WARNING *** For more information see Oct 28 21:13:05 volumiolg volumio[16945]: info: Applying required configuration parameters for plugin volumiodiscovery Oct 28 21:13:05 volumiolg volumio[16945]: info: Discovery: Started advertising with name: VolumioLG Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "spop"... Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "outputs"... Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "albumart"... Oct 28 21:13:06 volumiolg volumio[16945]: info: Plugin example_plugin is not enabled Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "inputs"... Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "updater_comm"... Oct 28 21:13:06 volumiolg volumio[16945]: info: Plugin mpdemulation is not enabled Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "rest_api"... Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "websocket"... Oct 28 21:13:06 volumiolg volumio[16945]: info: Starting Socket.io Server version 2.3.0 Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading plugin "fusiondsp"... Oct 28 21:13:06 volumiolg volumio[16945]: Forking 3 albumart workers Oct 28 21:13:06 volumiolg volumio[16945]: info: Applying required configuration parameters for plugin fusiondsp Oct 28 21:13:06 volumiolg volumio[16945]: info: Loading i18n strings for locale pt Oct 28 21:13:06 volumiolg volumio[16945]: Updating browse sources language Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::initPlayerControls Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: Express server listening on port 3000 Oct 28 21:13:06 volumiolg volumio[16945]: [Metrics] WebUI: 1s 808.09ms Oct 28 21:13:06 volumiolg volumio[16945]: info: Setting Device type: x86 Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreStateMachine::resetVolumioState Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreStateMachine::getcurrentVolume Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::volumioRetrievevolume Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreStateMachine::pushState Oct 28 21:13:06 volumiolg volumio[16945]: info: CorePlayQueue::getTrack 0 Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::volumioPushState Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: Starting albumart workers Oct 28 21:13:06 volumiolg volumio[16945]: Starting albumart workers Oct 28 21:13:06 volumiolg volumio[16945]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Oct 28 21:13:06 volumiolg volumio[16945]: info: Completed loading Core Plugins Oct 28 21:13:06 volumiolg volumio[16945]: info: Preparing to generate the ALSA configuration file Oct 28 21:13:06 volumiolg volumio[16945]: Starting albumart workers Oct 28 21:13:06 volumiolg kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Oct 28 21:13:06 volumiolg volumio[16945]: info: Volumio Network Manager: Network status updated: 2 Oct 28 21:13:06 volumiolg sudo[16998]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:06 volumiolg volumio[16945]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Oct 28 21:13:06 volumiolg volumio[16945]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 28 21:13:06 volumiolg volumio[16945]: info: Reading ALSA contributions from plugins. Oct 28 21:13:06 volumiolg volumio[16945]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Oct 28 21:13:06 volumiolg volumio[16945]: info: Cannot mount NAS MyCloud at system boot, trial number 1 ,retrying in 5 seconds Oct 28 21:13:06 volumiolg volumio[16945]: info: Reloading queue from file Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreStateMachine::setRepeat null single undefined Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreStateMachine::pushState Oct 28 21:13:06 volumiolg volumio[16945]: info: CorePlayQueue::getTrack 0 Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::volumioPushState Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreStateMachine::setRandom null Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreStateMachine::pushState Oct 28 21:13:06 volumiolg volumio[16945]: info: CorePlayQueue::getTrack 0 Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::volumioPushState Oct 28 21:13:06 volumiolg volumio[16945]: info: Asound.conf file unchanged, so no further update is needed Oct 28 21:13:06 volumiolg volumio[16945]: info: Output device has changed, restarting MPD Oct 28 21:13:06 volumiolg sudo[17052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 28 21:13:06 volumiolg sudo[17052]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:06 volumiolg volumio[16945]: info: Output device has changed, restarting Shairport Sync Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:06 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:06 volumiolg sudo[17052]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:06 volumiolg sudo[17054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 28 21:13:06 volumiolg sudo[17054]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:06 volumiolg systemd[1]: Stopping Music Player Daemon... Oct 28 21:13:06 volumiolg volumio[16945]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 28 21:13:06 volumiolg volumio[16945]: info: ___________ START PLUGINS ___________ Oct 28 21:13:06 volumiolg systemd[1]: mpd.service: Succeeded. Oct 28 21:13:06 volumiolg volumio[16945]: info: ControllerMpd::onStart: Initializing MPD Oct 28 21:13:06 volumiolg volumio[16945]: info: Creating MPD Configuration file Oct 28 21:13:06 volumiolg systemd[1]: Stopped Music Player Daemon. Oct 28 21:13:07 volumiolg systemd[1]: Starting Music Player Daemon... Oct 28 21:13:07 volumiolg sudo[17070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 28 21:13:07 volumiolg sudo[17070]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 28 21:13:07 volumiolg volumio[16945]: info: [1761696787030] CoreMusicLibrary::Adding element Servidores multimédia Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 21:13:07 volumiolg sudo[17070]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:07 volumiolg sudo[17089]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 28 21:13:07 volumiolg sudo[17089]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg sudo[17064]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 28 21:13:07 volumiolg sudo[17064]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg sudo[17064]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Oct 28 21:13:07 volumiolg systemd[1]: mpd.service: Succeeded. Oct 28 21:13:07 volumiolg systemd[1]: Stopped Music Player Daemon. Oct 28 21:13:07 volumiolg volumio[16945]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 28 21:13:07 volumiolg volumio[16945]: info: [1761696787097] CoreMusicLibrary::Adding element Last_100 Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 28 21:13:07 volumiolg volumio[16945]: info: [1761696787098] CoreMusicLibrary::Adding element Webradio Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 21:13:07 volumiolg systemd[1]: Starting Music Player Daemon... Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 28 21:13:07 volumiolg volumio[16945]: info: Initializing BBC Radios Oct 28 21:13:07 volumiolg sudo[17095]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 28 21:13:07 volumiolg sudo[17095]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg sudo[17095]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: Creating Spotify config file Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: Loading i18n strings for locale pt Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: FusionDsp - mixtype--------------------- None Oct 28 21:13:07 volumiolg volumio[16945]: info: Volumio Calling Home Oct 28 21:13:07 volumiolg volumio[16945]: info: Preparing to generate the ALSA configuration file Oct 28 21:13:07 volumiolg volumio[16945]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 28 21:13:07 volumiolg volumio[16945]: info: Reading ALSA contributions from plugins. Oct 28 21:13:07 volumiolg volumio[16945]: info: MPD Permissions set Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: No need to fix Spotify hosts Oct 28 21:13:07 volumiolg volumio[16945]: info: Spotify config file written Oct 28 21:13:07 volumiolg volumio[16945]: info: Starting Shairport Sync Oct 28 21:13:07 volumiolg sudo[17127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Oct 28 21:13:07 volumiolg sudo[17127]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg systemd[1]: Stopping go-librespot Daemon... Oct 28 21:13:07 volumiolg volumio[16945]: info: Starting Shairport Sync Oct 28 21:13:07 volumiolg systemd[1]: go-librespot-daemon.service: Main process exited, code=killed, status=15/TERM Oct 28 21:13:07 volumiolg systemd[1]: go-librespot-daemon.service: Succeeded. Oct 28 21:13:07 volumiolg systemd[1]: Stopped go-librespot Daemon. Oct 28 21:13:07 volumiolg sudo[17130]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 28 21:13:07 volumiolg sudo[17130]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg volumio[16945]: info: Starting Shairport Sync Oct 28 21:13:07 volumiolg sudo[17134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 28 21:13:07 volumiolg sudo[17134]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg systemd[1]: Started go-librespot Daemon. Oct 28 21:13:07 volumiolg go-librespot[17132]: go-librespot daemon starting... Oct 28 21:13:07 volumiolg volumio[16945]: info: Asound.conf file unchanged, so no further update is needed Oct 28 21:13:07 volumiolg volumio[16945]: info: Output device has changed, restarting MPD Oct 28 21:13:07 volumiolg go-librespot[17132]: time="2025-10-28T21:13:07-03:00" level=info msg="running go-librespot 0.4.0" Oct 28 21:13:07 volumiolg sudo[17127]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg go-librespot[17132]: time="2025-10-28T21:13:07-03:00" level=debug msg="app state loaded" Oct 28 21:13:07 volumiolg go-librespot[17132]: time="2025-10-28T21:13:07-03:00" level=info msg="api server listening on 127.0.0.1:9879" Oct 28 21:13:07 volumiolg systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 28 21:13:07 volumiolg systemd[1]: shairport-sync.service: Succeeded. Oct 28 21:13:07 volumiolg systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:07 volumiolg sudo[17137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 28 21:13:07 volumiolg sudo[17137]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:07 volumiolg sudo[17134]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg sudo[17130]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg sudo[17146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 28 21:13:07 volumiolg sudo[17146]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg volumio[16945]: info: Output device has changed, restarting Shairport Sync Oct 28 21:13:07 volumiolg sudo[17146]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:07 volumiolg systemd[1]: shairport-sync.service: Succeeded. Oct 28 21:13:07 volumiolg systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:07 volumiolg sudo[17152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 28 21:13:07 volumiolg sudo[17152]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg volumio[16945]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 28 21:13:07 volumiolg volumio[16945]: info: MPD Permissions set Oct 28 21:13:07 volumiolg systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:07 volumiolg volumio[16945]: info: Shairport-Sync Started Oct 28 21:13:07 volumiolg volumio[16945]: Error adding Membership: Error: addMembership EINVAL Oct 28 21:13:07 volumiolg volumio[16945]: info: Shairport-Sync Started Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg sudo[17137]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 28 21:13:07 volumiolg systemd[1]: mpd.service: Succeeded. Oct 28 21:13:07 volumiolg systemd[1]: Stopped Music Player Daemon. Oct 28 21:13:07 volumiolg systemd[1]: Starting Music Player Daemon... Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Oct 28 21:13:07 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:07 volumiolg volumio[16945]: info: Shairport-Sync Started Oct 28 21:13:07 volumiolg volumio[16945]: info: Starting Shairport Sync Oct 28 21:13:07 volumiolg sudo[17159]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 28 21:13:07 volumiolg sudo[17168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 28 21:13:07 volumiolg sudo[17159]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg sudo[17168]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:07 volumiolg sudo[17159]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 28 21:13:07 volumiolg systemd[1]: shairport-sync.service: Succeeded. Oct 28 21:13:07 volumiolg systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:07 volumiolg systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 28 21:13:07 volumiolg sudo[17168]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg volumio[16945]: info: Shairport-Sync Started Oct 28 21:13:07 volumiolg go-librespot[17132]: time="2025-10-28T21:13:07-03:00" level=debug msg="fetched new accesspoints: [ap-gue1.spotify.com:4070 ap-gue1.spotify.com:443 ap-gue1.spotify.com:80 ap-guc3.spotify.com:4070 ap-gew1.spotify.com:443 ap-gew4.spotify.com:80]" Oct 28 21:13:07 volumiolg go-librespot[17132]: time="2025-10-28T21:13:07-03:00" level=debug msg="fetched new dealers: [gue1-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Oct 28 21:13:07 volumiolg go-librespot[17132]: time="2025-10-28T21:13:07-03:00" level=debug msg="fetched new spclients: [gue1-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Oct 28 21:13:07 volumiolg go-librespot[17132]: time="2025-10-28T21:13:07-03:00" level=info msg="zeroconf server listening on port 42671" Oct 28 21:13:07 volumiolg mpd[17171]: Oct 28 21:13 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 28 21:13:07 volumiolg systemd[1]: Started Music Player Daemon. Oct 28 21:13:07 volumiolg sudo[17054]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg sudo[17152]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg sudo[17089]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:07 volumiolg volumio[16945]: info: Completed starting Core Plugins Oct 28 21:13:07 volumiolg volumio[16945]: info: ------------------------------------------- Oct 28 21:13:07 volumiolg volumio[16945]: info: ----- MyVolumio plugins startup ---- Oct 28 21:13:07 volumiolg volumio[16945]: info: ------------------------------------------- Oct 28 21:13:07 volumiolg volumio[16945]: info: [MyVolumio PluginManager] Fetching plans data.... Oct 28 21:13:07 volumiolg volumio[16945]: error: MPD error: The expression evaluated to a falsy value: Oct 28 21:13:07 volumiolg volumio[16945]: assert.ok(self.idling) Oct 28 21:13:07 volumiolg volumio[16945]: error: The expression evaluated to a falsy value: Oct 28 21:13:07 volumiolg volumio[16945]: assert.ok(self.idling) Oct 28 21:13:07 volumiolg volumio[16945]: error: MPD error: The expression evaluated to a falsy value: Oct 28 21:13:07 volumiolg volumio[16945]: assert.ok(self.idling) Oct 28 21:13:07 volumiolg volumio[16945]: error: The expression evaluated to a falsy value: Oct 28 21:13:07 volumiolg volumio[16945]: assert.ok(self.idling) Oct 28 21:13:07 volumiolg volumio[16945]: error: updateQueue error: null Oct 28 21:13:07 volumiolg volumio[16945]: info: MPD running with PID17171 Oct 28 21:13:07 volumiolg volumio[16945]: ,establishing connection Oct 28 21:13:07 volumiolg volumio[16945]: error: updateQueue error: null Oct 28 21:13:08 volumiolg volumio[16945]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 28 21:13:08 volumiolg go-librespot[17132]: time="2025-10-28T21:13:08-03:00" level=debug msg="obtained new client token: AACm7KxbcYGf2QZKFtfxXRvOCjAOuAe0rKvzSEAEjYAl4dA6+Ua+QIbU8rJN3yistgNsz7DEKce85ffbhT4FPfuvPRh1t6gLA6YPsTypZInmnxkk1Bi9KD6o/92OQVfYS2y4DhPdNbYv50yy0LL18ibyReO9/cDNWj8OLnpzQZa46FeIJHcNicLCgUJ9tU6pGx+0x3Sc/yxmVNAsmH9N1ViVkGVjSHXeCl5Oe65zikQhr6dvokRfvmpfBQ==" Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::volumioGetVisibleSources Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::volumioGetState Oct 28 21:13:08 volumiolg volumio[16945]: info: CorePlayQueue::getTrack 0 Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::volumioGetState Oct 28 21:13:08 volumiolg volumio[16945]: info: CorePlayQueue::getTrack 0 Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 28 21:13:08 volumiolg volumio[16945]: info: Received Get System Info Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 28 21:13:08 volumiolg volumio[16945]: info: Discovery: Getting this device information Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::volumioGetState Oct 28 21:13:08 volumiolg volumio[16945]: info: CorePlayQueue::getTrack 0 Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::volumioGetState Oct 28 21:13:08 volumiolg volumio[16945]: info: CorePlayQueue::getTrack 0 Oct 28 21:13:08 volumiolg volumio[16945]: info: Listing playlists Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 28 21:13:08 volumiolg volumio[16945]: info: FusionDsp - no preset used Oct 28 21:13:08 volumiolg go-librespot[17132]: time="2025-10-28T21:13:08-03:00" level=debug msg="connected to ap-gue1.spotify.com:4070" Oct 28 21:13:08 volumiolg volumio[16945]: info: FusionDsp - Oct 28 21:13:08 volumiolg volumio[16945]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 28 21:13:08 volumiolg volumio[16945]: info: FusionDsp - no preset used Oct 28 21:13:08 volumiolg go-librespot[17132]: time="2025-10-28T21:13:08-03:00" level=debug msg="completed keyexchange" Oct 28 21:13:08 volumiolg go-librespot[17132]: time="2025-10-28T21:13:08-03:00" level=debug msg="completed challenge" Oct 28 21:13:08 volumiolg volumio[16945]: info: FusionDsp - Oct 28 21:13:08 volumiolg sudo[16986]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:09 volumiolg volumio[16945]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 28 21:13:09 volumiolg volumio[16945]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Oct 28 21:13:09 volumiolg volumio[16945]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Oct 28 21:13:09 volumiolg volumio[16945]: info: camilladsp service started and running in background, instance 1 Oct 28 21:13:09 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 28 21:13:09 volumiolg volumio-remote-updater[760]: [2025-10-28 21:13:09] [connect] Successful connection Oct 28 21:13:09 volumiolg volumio[16945]: info: FusionDsp - AAAAAAAAAAAAAA-> 44100 48000 88200 96000 176400 192000 384000 768000 <-AAAAAAAAAAAAA Oct 28 21:13:09 volumiolg volumio[16945]: info: FusionDsp loaded Oct 28 21:13:09 volumiolg volumio[16945]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 28 21:13:09 volumiolg sudo[17191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 28 21:13:09 volumiolg sudo[17191]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 28 21:13:09 volumiolg volumio[16945]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 28 21:13:09 volumiolg volumio[16945]: info: Adding Signal Path Element [object Object] Oct 28 21:13:09 volumiolg volumio[16945]: info: Adding fusiondspeq DSP Signal Path Element Oct 28 21:13:09 volumiolg volumio[16945]: info: FusionDsp - ---- installed callbackRead Oct 28 21:13:09 volumiolg volumio[16945]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 21:13:09 volumiolg volumio[16945]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 28 21:13:09 volumiolg volumio[16945]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Oct 28 21:13:09 volumiolg volumio[16945]: at onErrorNT (internal/child_process.js:472:16) Oct 28 21:13:09 volumiolg volumio[16945]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Oct 28 21:13:09 volumiolg volumio[16945]: errno: -2, Oct 28 21:13:09 volumiolg volumio[16945]: code: 'ENOENT', Oct 28 21:13:09 volumiolg volumio[16945]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 28 21:13:09 volumiolg volumio[16945]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 28 21:13:09 volumiolg volumio[16945]: spawnargs: [ Oct 28 21:13:09 volumiolg volumio[16945]: '-p', Oct 28 21:13:09 volumiolg volumio[16945]: 9876, Oct 28 21:13:09 volumiolg volumio[16945]: '-o', Oct 28 21:13:09 volumiolg volumio[16945]: '/tmp/camilladsp.log', Oct 28 21:13:09 volumiolg volumio[16945]: '-l', Oct 28 21:13:09 volumiolg volumio[16945]: 'warn', Oct 28 21:13:09 volumiolg volumio[16945]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 28 21:13:09 volumiolg volumio[16945]: ] Oct 28 21:13:09 volumiolg volumio[16945]: } Oct 28 21:13:09 volumiolg volumio[16945]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 21:13:09 volumiolg go-librespot[17132]: time="2025-10-28T21:13:09-03:00" level=info msg="authenticated AP" username="ac**tz" Oct 28 21:13:09 volumiolg systemd[1]: Started FusionDsp Daemon. Oct 28 21:13:09 volumiolg sudo[17191]: pam_unix(sudo:session): session closed for user root Oct 28 21:13:09 volumiolg volumio[17193]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Oct 28 21:13:09 volumiolg systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Oct 28 21:13:09 volumiolg systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Oct 28 21:13:09 volumiolg sudo[17203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-28 21:12 Oct 28 21:13:09 volumiolg sudo[17203]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"