-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2026-02-21 11:18:09 CET. --
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.129+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/2XEQ15/
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/2XEQ15/.Bass-FusionDsp.json
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.152+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.154+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.203+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/2XEQ15/.Classic-FusionDsp.json
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.231+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio sudo[4297]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update
Feb 21 11:17:00 volumio sudo[4297]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/2XEQ15/.Voice-FusionDsp.json
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.263+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/2XEQ15/.Rock-FusionDsp.json
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.286+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/PEQ/
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/convfir/
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/convfir/kef.json
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/convfir/test.json
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/EQ15/
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/EQ15/.Bass-FusionDsp.json
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/EQ15/.Classic-FusionDsp.json
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/EQ15/.Voice-FusionDsp.json
Feb 21 11:17:00 volumio volumio[3765]: info: ./presets/EQ15/.Rock-FusionDsp.json
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.324+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.326+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.328+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.331+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.333+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.335+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.337+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.340+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.342+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.344+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:00 volumio volumio[3765]: info: Installing/fusiondsp dependencies
Feb 21 11:17:00 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:00.503+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:01 volumio volumio[3765]: info: Hit:1 https://archive2.volumio.org/debian buster InRelease
Feb 21 11:17:01 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:01.346+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:01 volumio volumio[3765]: info: Hit:2 https://apt2.volumio.org/raspbian buster InRelease
Feb 21 11:17:01 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:01.377+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:12 volumio volumio[3765]: info: Reading package lists...
Feb 21 11:17:12 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:12.228+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:13 volumio volumio[3765]: info: Building dependency tree...
Feb 21 11:17:13 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:13.867+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:14 volumio volumio[3765]: info: Reading state information...
Feb 21 11:17:14 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:14.272+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:14 volumio volumio[3765]: info: 119 packages can be upgraded. Run 'apt list --upgradable' to see them.
Feb 21 11:17:14 volumio sudo[4297]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:14 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:14.427+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:14 volumio sudo[4457]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip
Feb 21 11:17:14 volumio sudo[4457]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:15 volumio sudo[4457]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:15 volumio sudo[4460]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C /
Feb 21 11:17:15 volumio sudo[4460]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:15 volumio volumio[3765]: info: lib/systemd/system/fusiondsp.service
Feb 21 11:17:15 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:15.240+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:16 volumio sudo[4460]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:25 volumio volumio[3765]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.403+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio[3765]: info: more info at http://www.winimage.com/zLibDll/unzip.html
Feb 21 11:17:25 volumio volumio[3765]: info:
Feb 21 11:17:25 volumio volumio[3765]: info: cgui-1.0.0.zip opened
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/LICENSE.txt
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/README.md
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/build/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/robots.txt
Feb 21 11:17:25 volumio sudo[4478]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/logo512.png
Feb 21 11:17:25 volumio sudo[4478]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/asset-manifest.json
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/index.html
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/.put_statics_here
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/favicon.ico
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/logo192.png
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/manifest.json
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/css-variables.css
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js
Feb 21 11:17:25 volumio sudo[4478]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/service-worker.js
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/build/static/
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/build/static/css/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/main.1503f6cd.css
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/build/static/media/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/build/static/js/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/main.71e11955.js
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js
Feb 21 11:17:25 volumio sudo[4480]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt
Feb 21 11:17:25 volumio sudo[4480]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/main.71e11955.js.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/config/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/config/camillagui.yml
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/config/gui-config.yml
Feb 21 11:17:25 volumio sudo[4480]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/backend/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/filters_test.py
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/version.py
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/filters.py
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/settings.py
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/views.py
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/filterdefaults.py
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__init__.py
Feb 21 11:17:25 volumio volumio[3765]: info: creating directory: cgui/backend/__pycache__/
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc
Feb 21 11:17:25 volumio sudo[4482]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/routes.py
Feb 21 11:17:25 volumio sudo[4482]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/backend/filemanagement.py
Feb 21 11:17:25 volumio volumio[3765]: info: extracting: cgui/main.py
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.609+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.611+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.615+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.616+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.617+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio sudo[4482]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.621+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.624+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.625+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.628+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.632+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.634+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.637+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.639+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.641+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.644+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.647+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.649+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.652+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.655+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.657+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.660+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.662+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.665+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.668+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.670+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.673+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.676+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.678+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.681+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.684+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.686+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.689+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.692+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.695+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.697+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.700+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.703+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.706+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.709+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.711+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.714+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.717+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.719+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.722+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.725+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.728+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.731+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.734+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.737+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.739+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.743+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.745+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.749+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.751+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.754+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.757+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.761+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.763+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.767+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.769+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.771+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.774+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.777+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.781+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.783+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.786+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.790+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.791+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.795+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.797+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.801+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.803+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.815+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.820+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:25 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:25.821+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:30 volumio volumio[3765]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Feb 21 11:17:30 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:30.306+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:39 volumio volumio[3765]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple
Feb 21 11:17:39 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:39.228+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:39 volumio volumio[3765]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0
Feb 21 11:17:39 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:39.264+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:39 volumio volumio[3765]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-_3_7mq3w
Feb 21 11:17:39 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:39.299+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 21 11:17:39 volumio volumio[3765]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf
Feb 21 11:17:39 volumio volumio[3765]: info: FusionDsp - Stopping FusionDsp service
Feb 21 11:17:39 volumio volumio[3765]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 11:17:39 volumio volumio[3765]: TypeError: Cannot read property 'stop' of null
Feb 21 11:17:39 volumio volumio[3765]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23)
Feb 21 11:17:39 volumio volumio[3765]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Feb 21 11:17:39 volumio volumio[3765]: at /volumio/app/pluginmanager.js:956:12
Feb 21 11:17:39 volumio volumio[3765]: at ChildProcess.exithandler (child_process.js:299:7)
Feb 21 11:17:39 volumio volumio[3765]: at ChildProcess.emit (events.js:315:20)
Feb 21 11:17:39 volumio volumio[3765]: at maybeClose (internal/child_process.js:1048:16)
Feb 21 11:17:39 volumio volumio[3765]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5)
Feb 21 11:17:39 volumio volumio[3765]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 11:17:41 volumio sudo[4559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 11:16
Feb 21 11:17:41 volumio sudo[4559]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:41 volumio sudo[4559]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:41 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:41.410+01:00 level=ERROR msg="failed reading message" component=volumio/socket error="read tcp 127.0.0.1:53448->127.0.0.1:3000: read: connection reset by peer"
Feb 21 11:17:41 volumio volumio-remote-updater[478]: [2026-02-21 11:17:41] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Feb 21 11:17:41 volumio volumio-remote-updater[478]: [2026-02-21 11:17:41] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Feb 21 11:17:41 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Feb 21 11:17:41 volumio sudo[4272]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:41 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:41.426+01:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused"
Feb 21 11:17:41 volumio systemd[1]: volumio.service: Failed with result 'exit-code'.
Feb 21 11:17:41 volumio systemd[1]: Started dynamicswap service.
Feb 21 11:17:41 volumio systemd[1]: dynamicswap.service: Succeeded.
Feb 21 11:17:41 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Feb 21 11:17:41 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3.
Feb 21 11:17:41 volumio systemd[1]: Started dynamicswap service.
Feb 21 11:17:41 volumio systemd[1]: Stopped Volumio Backend Module.
Feb 21 11:17:41 volumio systemd[1]: Started Volumio Backend Module.
Feb 21 11:17:41 volumio systemd[1]: dynamicswap.service: Succeeded.
Feb 21 11:17:42 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:42.431+01:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused"
Feb 21 11:17:43 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:43.435+01:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="dial tcp 127.0.0.1:3000: connect: connection refused"
Feb 21 11:17:45 volumio volumio[4570]: info: -------------------------------------------
Feb 21 11:17:45 volumio volumio[4570]: info: ----- Volumio3 ----
Feb 21 11:17:45 volumio volumio[4570]: info: -------------------------------------------
Feb 21 11:17:45 volumio volumio[4570]: info: ----- System startup ----
Feb 21 11:17:45 volumio volumio[4570]: info: -------------------------------------------
Feb 21 11:17:46 volumio volumio-remote-updater[478]: [2026-02-21 11:17:46] [connect] Successful connection
Feb 21 11:17:47 volumio volumio[4570]: info: MYVOLUMIO Environment detected
Feb 21 11:17:47 volumio volumio[4570]: info: Plugin folders cleanup
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning into folder /volumio/app/plugins/
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category audio_interface
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category miscellanea
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category music_service
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category plugins.json
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category system_controller
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category user_interface
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning into folder /data/plugins/
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category audio_interface
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category music_service
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category system_controller
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category system_hardware
Feb 21 11:17:47 volumio volumio[4570]: info: Scanning category user_interface
Feb 21 11:17:47 volumio volumio[4570]: info: Plugin folders cleanup completed
Feb 21 11:17:47 volumio volumio[4570]: info: -------------------------------------------
Feb 21 11:17:47 volumio volumio[4570]: info: ----- Core plugins startup ----
Feb 21 11:17:47 volumio volumio[4570]: info: -------------------------------------------
Feb 21 11:17:47 volumio volumio[4570]: info: Loading plugins from folder /volumio/app/plugins/
Feb 21 11:17:47 volumio volumio[4570]: info: Adding plugin upnp to MyMusic Plugins
Feb 21 11:17:47 volumio volumio[4570]: info: Adding plugin airplay_emulation to MyMusic Plugins
Feb 21 11:17:47 volumio volumio[4570]: info: Adding plugin upnp_browser to MyMusic Plugins
Feb 21 11:17:47 volumio volumio[4570]: info: Loading plugins from folder /data/plugins/
Feb 21 11:17:47 volumio volumio[4570]: info: Loading plugin "system"...
Feb 21 11:17:47 volumio volumio[4570]: info: Loading plugin "appearance"...
Feb 21 11:17:49 volumio volumio[4570]: info: Loading plugin "network"...
Feb 21 11:17:49 volumio volumio[4570]: info: Refreshing Cached IP Addresses
Feb 21 11:17:49 volumio sudo[4597]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 21 11:17:49 volumio sudo[4597]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:49 volumio sudo[4597]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:49 volumio sudo[4599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 21 11:17:49 volumio sudo[4599]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:49 volumio sudo[4599]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:49 volumio volumio[4570]: info: Loading plugin "services"...
Feb 21 11:17:49 volumio volumio[4570]: info: Loading plugin "volumio5onboarding"...
Feb 21 11:17:49 volumio sudo[4608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Feb 21 11:17:49 volumio sudo[4608]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:17:49 volumio volumio[4570]: info: Loading plugin "alsa_controller"...
Feb 21 11:17:49 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 11:17:49 volumio volumio[4570]: info: Loading plugin "wizard"...
Feb 21 11:17:49 volumio volumio[4570]: info: Loading plugin "networkfs"...
Feb 21 11:17:49 volumio volumio[4570]: info: Cannot mount NAS Nas at system boot, trial number 1 ,retrying in 5 seconds
Feb 21 11:17:49 volumio volumio[4570]: info: Starting Udev Watcher for removable devices
Feb 21 11:17:49 volumio volumio[4570]: info: Ignoring mount for partition: boot
Feb 21 11:17:49 volumio volumio[4570]: info: Ignoring mount for partition: volumio
Feb 21 11:17:49 volumio volumio[4570]: info: Ignoring mount for partition: volumio_data
Feb 21 11:17:49 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 21 11:17:49 volumio volumio[4570]: info: Loading plugin "volumio_command_line_client"...
Feb 21 11:17:50 volumio volumio[4570]: info: Loading plugin "upnp"...
Feb 21 11:17:50 volumio volumio[4570]: info: [1771669070016] Starting Upmpd Daemon
Feb 21 11:17:50 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 21 11:17:50 volumio volumio[4570]: info: Loading plugin "my_music"...
Feb 21 11:17:50 volumio volumio[4570]: info: Loading plugin "mpd"...
Feb 21 11:17:50 volumio volumio[4570]: info: Loading plugin "upnp_browser"...
Feb 21 11:17:51 volumio volumio[4570]: info: Starting UPNP Browser
Feb 21 11:17:51 volumio volumio[4570]: info: Loading plugin "alarm-clock"...
Feb 21 11:17:51 volumio sudo[4608]: pam_unix(sudo:session): session closed for user root
Feb 21 11:17:51 volumio volumio[4570]: info: Loading plugin "airplay_emulation"...
Feb 21 11:17:51 volumio volumio[4570]: info: Starting Shairport Sync
Feb 21 11:17:51 volumio volumio[4570]: info: Loading plugin "last_100"...
Feb 21 11:17:51 volumio volumio[4570]: info: Loading plugin "webradio"...
Feb 21 11:17:51 volumio volumio[4570]: info: Loading plugin "i2s_dacs"...
Feb 21 11:17:51 volumio volumio[4570]: info: Loading plugin "volumiodiscovery"...
Feb 21 11:17:51 volumio volumio[4570]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 21 11:17:51 volumio volumio[4570]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 11:17:51 volumio node[4570]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Feb 21 11:17:51 volumio volumio[4570]: *** WARNING *** For more information see
Feb 21 11:17:51 volumio volumio[4570]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 21 11:17:51 volumio volumio[4570]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 11:17:51 volumio volumio[4570]: *** WARNING *** For more information see
Feb 21 11:17:51 volumio node[4570]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 11:17:51 volumio node[4570]: *** WARNING *** For more information see
Feb 21 11:17:51 volumio node[4570]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Feb 21 11:17:51 volumio node[4570]: *** WARNING *** Please fix your application to use the native API of Avahi!
Feb 21 11:17:51 volumio node[4570]: *** WARNING *** For more information see
Feb 21 11:17:51 volumio volumio[4570]: info: Applying required configuration parameters for plugin volumiodiscovery
Feb 21 11:17:52 volumio volumio[4570]: info: Discovery: Started advertising with name: Volumio
Feb 21 11:17:52 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Feb 21 11:17:52 volumio volumio[4570]: info: Loading plugin "ytmusic"...
Feb 21 11:17:54 volumio volumio5-onboarding[1398]: time=2026-02-21T11:17:54.438+01:00 level=WARN msg="reconnection attempt failed" component=volumio/socket error="read tcp 127.0.0.1:55754->127.0.0.1:3000: i/o timeout"
Feb 21 11:17:58 volumio volumio[4570]: info: Loading plugin "outputs"...
Feb 21 11:17:58 volumio volumio[4570]: info: Loading plugin "albumart"...
Feb 21 11:17:58 volumio volumio[4570]: info: Plugin example_plugin is not enabled
Feb 21 11:17:58 volumio volumio[4570]: info: Loading plugin "inputs"...
Feb 21 11:17:58 volumio volumio[4570]: info: Loading plugin "updater_comm"...
Feb 21 11:17:58 volumio volumio[4570]: info: Plugin mpdemulation is not enabled
Feb 21 11:17:58 volumio volumio[4570]: info: Loading plugin "rest_api"...
Feb 21 11:17:58 volumio volumio[4570]: info: Loading plugin "websocket"...
Feb 21 11:17:58 volumio volumio[4570]: info: Starting Socket.io Server version 2.3.0
Feb 21 11:17:58 volumio volumio[4570]: info: Loading plugin "fusiondsp"...
Feb 21 11:17:58 volumio volumio-remote-updater[478]: [2026-02-21 11:17:58] [connect] Successful connection
Feb 21 11:17:59 volumio volumio[4570]: Forking 3 albumart workers
Feb 21 11:17:59 volumio volumio[4570]: info: Applying required configuration parameters for plugin fusiondsp
Feb 21 11:17:59 volumio volumio[4570]: info: Loading plugin "radio_paradise"...
Feb 21 11:18:00 volumio volumio[4570]: info: Applying required configuration parameters for plugin radio_paradise
Feb 21 11:18:00 volumio volumio[4570]: info: [1771669080116] [RadioParadise] API delay: 5
Feb 21 11:18:00 volumio volumio[4570]: info: Loading plugin "backup_restore"...
Feb 21 11:18:00 volumio volumio[4570]: info: Applying required configuration parameters for plugin backup_restore
Feb 21 11:18:00 volumio volumio[4570]: info: Loading plugin "mpd_oled"...
Feb 21 11:18:01 volumio volumio[4570]: info: Applying required configuration parameters for plugin mpd_oled
Feb 21 11:18:01 volumio volumio[4570]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json
Feb 21 11:18:01 volumio volumio[4570]: info: Loading plugin "Systeminfo"...
Feb 21 11:18:01 volumio volumio[4570]: Starting albumart workers
Feb 21 11:18:01 volumio volumio[4570]: Starting albumart workers
Feb 21 11:18:01 volumio volumio[4570]: Starting albumart workers
Feb 21 11:18:02 volumio volumio[4570]: info: Loading i18n strings for locale it
Feb 21 11:18:02 volumio volumio[4570]: Updating browse sources language
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::initPlayerControls
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 11:18:02 volumio volumio[4570]: Express server listening on port 3000
Feb 21 11:18:02 volumio volumio[4570]: [Metrics] WebUI: 18s 733.72ms
Feb 21 11:18:02 volumio volumio[4570]: info: CoreStateMachine::resetVolumioState
Feb 21 11:18:02 volumio volumio[4570]: info: CoreStateMachine::getcurrentVolume
Feb 21 11:18:02 volumio volumio[4570]: info: CoreCommandRouter::volumioRetrievevolume
Feb 21 11:18:03 volumio volumio[4570]: info: CoreStateMachine::pushState
Feb 21 11:18:03 volumio volumio[4570]: info: CorePlayQueue::getTrack 0
Feb 21 11:18:03 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 21 11:18:03 volumio volumio[4570]: info: CoreCommandRouter::volumioPushState
Feb 21 11:18:03 volumio volumio[4570]: info: Cannot mount NAS Nas at system boot, trial number 2 ,retrying in 5 seconds
Feb 21 11:18:03 volumio sudo[4690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 21 11:18:03 volumio sudo[4690]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:03 volumio sudo[4690]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:03 volumio sudo[4696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 21 11:18:03 volumio sudo[4696]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:03 volumio sudo[4696]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:03 volumio volumio[4570]: info: Volumio Network Manager: Network status updated: 2
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to 192.168.1.125 from 192.168.1.90 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 1
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to 192.168.1.125 from 192.168.1.90 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 2
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to 192.168.1.125 from 192.168.1.90 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 3
Feb 21 11:18:03 volumio volumio-remote-updater[478]: [2026-02-21 11:18:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1771669078 101
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to 192.168.1.125 from 192.168.1.90 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/16.6.1 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 5
Feb 21 11:18:03 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:03 volumio volumio[4570]: info: Reloading queue from file
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:03 volumio volumio[4570]: info: Setting Device type: Raspberry PI
Feb 21 11:18:03 volumio volumio[4570]: info: CoreStateMachine::setRepeat false single undefined
Feb 21 11:18:03 volumio volumio[4570]: info: CoreStateMachine::pushState
Feb 21 11:18:03 volumio volumio[4570]: info: CorePlayQueue::getTrack 0
Feb 21 11:18:03 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 21 11:18:03 volumio volumio[4570]: info: CoreCommandRouter::volumioPushState
Feb 21 11:18:03 volumio volumio[4570]: info: CoreStateMachine::setRandom false
Feb 21 11:18:03 volumio volumio[4570]: info: CoreStateMachine::pushState
Feb 21 11:18:03 volumio volumio[4570]: info: CorePlayQueue::getTrack 0
Feb 21 11:18:03 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 21 11:18:03 volumio volumio[4570]: info: CoreCommandRouter::volumioPushState
Feb 21 11:18:03 volumio volumio[4570]: info: Completed loading Core Plugins
Feb 21 11:18:03 volumio volumio[4570]: info: Preparing to generate the ALSA configuration file
Feb 21 11:18:03 volumio volumio[4570]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 21 11:18:03 volumio volumio[4570]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf
Feb 21 11:18:03 volumio volumio[4570]: info: Reading ALSA contributions from plugins.
Feb 21 11:18:03 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:04 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:04 volumio sudo[4705]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 21 11:18:04 volumio sudo[4705]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:04 volumio volumio[4570]: info: Discovery: adding 66d1e038-50f5-4aa2-89fc-b15f5d428254
Feb 21 11:18:04 volumio volumio[4570]: info: Discovery: Found device Volumio
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::volumioGetState
Feb 21 11:18:04 volumio volumio[4570]: info: CorePlayQueue::getTrack 0
Feb 21 11:18:04 volumio sudo[4705]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:04 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:04 volumio volumio[4570]: info: Upmpdcli Daemon Started
Feb 21 11:18:04 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:04 volumio volumio[4570]: info: Asound.conf file unchanged, so no further update is needed
Feb 21 11:18:04 volumio volumio[4570]: info: Output device has changed, restarting MPD
Feb 21 11:18:04 volumio volumio[4570]: info: Output device has changed, restarting Shairport Sync
Feb 21 11:18:04 volumio sudo[4708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:04 volumio sudo[4708]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:04 volumio sudo[4708]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:04 volumio sudo[4710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 11:18:04 volumio sudo[4710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:04 volumio systemd[1]: Stopping Music Player Daemon...
Feb 21 11:18:04 volumio volumio[4570]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 11:18:04 volumio volumio[4570]: info: ___________ START PLUGINS ___________
Feb 21 11:18:04 volumio volumio[4570]: info: ControllerMpd::onStart: Initializing MPD
Feb 21 11:18:04 volumio volumio[4570]: info: Creating MPD Configuration file
Feb 21 11:18:04 volumio sudo[4717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Feb 21 11:18:04 volumio systemd[1]: mpd.service: Succeeded.
Feb 21 11:18:04 volumio sudo[4717]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:04 volumio systemd[1]: Stopped Music Player Daemon.
Feb 21 11:18:04 volumio sudo[4719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 11:18:04 volumio sudo[4719]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 11:18:04 volumio volumio[4570]: info: [1771669084519] CoreMusicLibrary::Adding element Server multimediali
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 11:18:04 volumio volumio[4570]: info: UPNP Browser: Client initialized successfully
Feb 21 11:18:04 volumio sudo[4719]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:04 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 11:18:04 volumio sudo[4723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 11:18:04 volumio sudo[4723]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:04 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Feb 21 11:18:04 volumio systemd[1]: mpd.service: Succeeded.
Feb 21 11:18:04 volumio systemd[1]: Stopped Music Player Daemon.
Feb 21 11:18:04 volumio sudo[4717]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:04 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 11:18:04 volumio volumio[4570]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:04 volumio volumio[4570]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 11:18:04 volumio volumio[4570]: info: [1771669084834] CoreMusicLibrary::Adding element Last_100
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 11:18:04 volumio volumio[4570]: info: [1771669084841] CoreMusicLibrary::Adding element Webradio
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 11:18:04 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 11:18:04 volumio volumio[4570]: info: Initializing BBC Radios
Feb 21 11:18:04 volumio sudo[4727]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 21 11:18:04 volumio sudo[4727]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:04 volumio sudo[4727]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 11:18:05 volumio volumio[4570]: info: [1771669085020] CoreMusicLibrary::Adding element YouTube Music
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 11:18:05 volumio volumio[4570]: Cannot find translation for source YouTube Music
Feb 21 11:18:05 volumio volumio[4570]: info: Loading i18n strings for locale it
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:05 volumio volumio[4570]: info: FusionDsp - mixtype--------------------- None
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 21 11:18:05 volumio volumio[4570]: info: [1771669085084] CoreMusicLibrary::Adding element Radio Paradise
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 21 11:18:05 volumio volumio[4570]: Cannot find translation for source YouTube Music
Feb 21 11:18:05 volumio volumio[4570]: Cannot find translation for source Radio Paradise
Feb 21 11:18:05 volumio volumio[4570]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists
Feb 21 11:18:05 volumio volumio[4570]: error: [MPD_OLED Plugin] Failed to create mpdoledfifo: Error: Command failed: /usr/bin/mkfifo -m 646 /tmp/mpdoledfifo
Feb 21 11:18:05 volumio volumio[4570]: /usr/bin/mkfifo: cannot create fifo '/tmp/mpdoledfifo': File exists
Feb 21 11:18:05 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 21 11:18:05 volumio volumio[4570]: info: [MPD_OLED Plugin] Not starting mpd_oled service because oled type is not configured yet
Feb 21 11:18:05 volumio volumio[4570]: info: Volumio Calling Home
Feb 21 11:18:05 volumio volumio[4570]: info: Preparing to generate the ALSA configuration file
Feb 21 11:18:05 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:05 volumio volumio[4570]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 21 11:18:05 volumio volumio[4570]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf
Feb 21 11:18:05 volumio volumio[4570]: info: Reading ALSA contributions from plugins.
Feb 21 11:18:05 volumio volumio[4570]: info: MPD Permissions set
Feb 21 11:18:05 volumio volumio[4570]: info: MPD Permissions set
Feb 21 11:18:05 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:05 volumio volumio[4570]: info: Volumio called home
Feb 21 11:18:05 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 6
Feb 21 11:18:06 volumio volumio[4570]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:06 volumio volumio[4570]: info: Starting Shairport Sync
Feb 21 11:18:06 volumio volumio[4570]: info: Starting Shairport Sync
Feb 21 11:18:06 volumio volumio[4570]: info: Starting Shairport Sync
Feb 21 11:18:06 volumio sudo[4759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 11:18:06 volumio sudo[4759]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:06 volumio sudo[4761]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 11:18:06 volumio sudo[4761]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:06 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 21 11:18:06 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 21 11:18:06 volumio volumio[4570]: info: CoreCommandRouter::volumioGetState
Feb 21 11:18:06 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 21 11:18:06 volumio volumio[4570]: info: CorePlayQueue::getTrack 0
Feb 21 11:18:06 volumio sudo[4765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 21 11:18:06 volumio sudo[4765]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:06 volumio volumio[4570]: info: Asound.conf file unchanged, so no further update is needed
Feb 21 11:18:06 volumio volumio[4570]: info: Output device has changed, restarting MPD
Feb 21 11:18:06 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 21 11:18:06 volumio sudo[4759]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Feb 21 11:18:07 volumio sudo[4769]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 21 11:18:07 volumio volumio[4570]: info: Output device has changed, restarting Shairport Sync
Feb 21 11:18:07 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:07 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 21 11:18:07 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Feb 21 11:18:07 volumio systemd[1]: shairport-sync.service: Succeeded.
Feb 21 11:18:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Feb 21 11:18:07 volumio sudo[4769]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:07 volumio sudo[4769]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Feb 21 11:18:07 volumio sudo[4761]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:07 volumio sudo[4765]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:07 volumio sudo[4771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 21 11:18:07 volumio sudo[4771]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:07 volumio volumio[4570]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 21 11:18:07 volumio volumio[4570]: info: Preparing to generate the ALSA configuration file
Feb 21 11:18:07 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Feb 21 11:18:07 volumio systemd[1]: mpd.service: Succeeded.
Feb 21 11:18:07 volumio systemd[1]: Stopped Music Player Daemon.
Feb 21 11:18:07 volumio systemd[1]: Starting Music Player Daemon...
Feb 21 11:18:07 volumio volumio[4570]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Feb 21 11:18:07 volumio volumio[4570]: 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
Feb 21 11:18:07 volumio volumio[4570]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Feb 21 11:18:07 volumio volumio[4570]: info: camilladsp service started and running in background, instance 1
Feb 21 11:18:07 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 21 11:18:07 volumio volumio[4570]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 21 11:18:07 volumio volumio[4570]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Feb 21 11:18:07 volumio volumio[4570]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 21 11:18:07 volumio volumio[4570]: info: FusionDsp loaded
Feb 21 11:18:07 volumio volumio[4570]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 21 11:18:07 volumio sudo[4779]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 21 11:18:07 volumio sudo[4793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Feb 21 11:18:07 volumio sudo[4779]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:07 volumio sudo[4793]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 21 11:18:07 volumio sudo[4779]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:07 volumio volumio[4570]: info: FusionDsp - Reporting Fusion DSP Enabled
Feb 21 11:18:07 volumio volumio[4570]: info: Adding Signal Path Element [object Object]
Feb 21 11:18:07 volumio volumio[4570]: info: Adding fusiondspeq DSP Signal Path Element
Feb 21 11:18:07 volumio volumio[4570]: info: FusionDsp - ---- installed callbackRead
Feb 21 11:18:07 volumio volumio[4570]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 11:18:07 volumio volumio[4570]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Feb 21 11:18:07 volumio volumio[4570]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Feb 21 11:18:07 volumio volumio[4570]: at onErrorNT (internal/child_process.js:465:16)
Feb 21 11:18:07 volumio volumio[4570]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Feb 21 11:18:07 volumio volumio[4570]: at runNextTicks (internal/process/task_queues.js:62:3)
Feb 21 11:18:07 volumio volumio[4570]: at listOnTimeout (internal/timers.js:523:9)
Feb 21 11:18:07 volumio volumio[4570]: at processTimers (internal/timers.js:497:7) {
Feb 21 11:18:07 volumio volumio[4570]: errno: -2,
Feb 21 11:18:07 volumio volumio[4570]: code: 'ENOENT',
Feb 21 11:18:07 volumio volumio[4570]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 21 11:18:07 volumio volumio[4570]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 21 11:18:07 volumio volumio[4570]: spawnargs: [
Feb 21 11:18:07 volumio volumio[4570]: '-p',
Feb 21 11:18:07 volumio volumio[4570]: 9876,
Feb 21 11:18:07 volumio volumio[4570]: '-o',
Feb 21 11:18:07 volumio volumio[4570]: '/tmp/camilladsp.log',
Feb 21 11:18:07 volumio volumio[4570]: '-l',
Feb 21 11:18:07 volumio volumio[4570]: 'warn',
Feb 21 11:18:07 volumio volumio[4570]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Feb 21 11:18:07 volumio volumio[4570]: ]
Feb 21 11:18:07 volumio volumio[4570]: }
Feb 21 11:18:07 volumio volumio[4570]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 21 11:18:07 volumio systemd[1]: Started FusionDsp Daemon.
Feb 21 11:18:07 volumio sudo[4793]: pam_unix(sudo:session): session closed for user root
Feb 21 11:18:09 volumio sudo[4807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 11:17
Feb 21 11:18:09 volumio sudo[4807]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET"
VOLUMIO_VERSION="3.908"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"