-- Logs begin at Tue 2026-06-02 20:47:15 JST, end at Tue 2026-06-02 21:11:32 JST. -- Jun 02 21:10:01 rivo volumio[7512]: info: Reading package lists... Jun 02 21:10:01 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:01.970+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:02 rivo volumio[7512]: info: Building dependency tree... Jun 02 21:10:02 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:02.786+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:02 rivo volumio[7512]: info: Reading state information... Jun 02 21:10:02 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:02.795+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:02 rivo volumio[7512]: info: All packages are up to date. Jun 02 21:10:02 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:02.874+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:02 rivo sudo[9416]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:02 rivo sudo[9545]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Jun 02 21:10:02 rivo sudo[9545]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:03 rivo volumio[7512]: info: Reading package lists... Jun 02 21:10:03 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:03.085+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:03 rivo volumio[7512]: info: Building dependency tree... Jun 02 21:10:03 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:03.787+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:03 rivo volumio[7512]: info: Reading state information... Jun 02 21:10:03 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:03.796+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:05 rivo volumio[7512]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1). Jun 02 21:10:05 rivo sudo[9545]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:05 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:05.210+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:05 rivo volumio[7512]: info: python3-pip is already the newest version (18.1-5). Jun 02 21:10:05 rivo volumio[7512]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Jun 02 21:10:05 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:05.220+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:05 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:05.221+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:05 rivo sudo[9549]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Jun 02 21:10:05 rivo sudo[9549]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:05 rivo volumio[7512]: info: lib/systemd/system/fusiondsp.service Jun 02 21:10:05 rivo sudo[9549]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:05 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:05.251+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio[7512]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.147+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio[7512]: info: more info at http://www.winimage.com/zLibDll/unzip.html Jun 02 21:10:08 rivo volumio[7512]: info: Jun 02 21:10:08 rivo volumio[7512]: info: cgui-1.0.0.zip opened Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/ Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/LICENSE.txt Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/README.md Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/build/ Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/robots.txt Jun 02 21:10:08 rivo sudo[9570]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Jun 02 21:10:08 rivo sudo[9570]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/logo512.png Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/asset-manifest.json Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/index.html Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/.put_statics_here Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/favicon.ico Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/logo192.png Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/manifest.json Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/css-variables.css Jun 02 21:10:08 rivo sudo[9570]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/service-worker.js Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/build/static/ Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/build/static/css/ Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/main.1503f6cd.css Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/build/static/media/ Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Jun 02 21:10:08 rivo sudo[9572]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/build/static/js/ Jun 02 21:10:08 rivo sudo[9572]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/main.71e11955.js Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Jun 02 21:10:08 rivo sudo[9572]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/main.71e11955.js.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/config/ Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/config/camillagui.yml Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/config/gui-config.yml Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/backend/ Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/filters_test.py Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/version.py Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/filters.py Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/settings.py Jun 02 21:10:08 rivo sudo[9574]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/views.py Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/filterdefaults.py Jun 02 21:10:08 rivo sudo[9574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__init__.py Jun 02 21:10:08 rivo volumio[7512]: info: creating directory: cgui/backend/__pycache__/ Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Jun 02 21:10:08 rivo sudo[9574]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/routes.py Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/backend/filemanagement.py Jun 02 21:10:08 rivo volumio[7512]: info: extracting: cgui/main.py Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.451+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.452+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.459+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.461+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.463+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.470+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.472+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.474+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.476+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.477+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.478+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.478+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.479+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.479+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.480+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.481+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.482+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.483+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.484+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.485+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.486+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.486+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.487+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.488+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.490+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.491+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.492+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.493+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.494+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.495+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.496+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.497+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.499+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.499+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.500+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.501+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.502+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.504+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.506+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.507+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.508+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.509+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.510+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.511+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.512+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.514+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.504+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.515+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.513+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.516+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.517+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.518+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.519+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:08 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:08.520+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:12 rivo volumio[7512]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivo/buster/armhf Jun 02 21:10:12 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:12.189+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Jun 02 21:10:15 rivo volumio[7512]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/rivo/buster/armhf Jun 02 21:10:15 rivo volumio[7512]: info: FusionDsp - Stopping FusionDsp service Jun 02 21:10:15 rivo volumio[7512]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:10:15 rivo volumio[7512]: TypeError: Cannot read property 'stop' of null Jun 02 21:10:15 rivo volumio[7512]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Jun 02 21:10:15 rivo volumio[7512]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 02 21:10:15 rivo volumio[7512]: at /volumio/app/pluginmanager.js:956:12 Jun 02 21:10:15 rivo volumio[7512]: at ChildProcess.exithandler (child_process.js:374:7) Jun 02 21:10:15 rivo volumio[7512]: at ChildProcess.emit (events.js:400:28) Jun 02 21:10:15 rivo volumio[7512]: at maybeClose (internal/child_process.js:1088:16) Jun 02 21:10:15 rivo volumio[7512]: at Process.ChildProcess._handle.onexit (internal/child_process.js:296:5) Jun 02 21:10:15 rivo volumio[7512]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:10:16 rivo sudo[9596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 21:09 Jun 02 21:10:16 rivo sudo[9596]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:16 rivo sudo[9596]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:16 rivo volumio-remote-updater[2832]: [2026-06-02 21:10:16] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 02 21:10:16 rivo volumio-remote-updater[2832]: [2026-06-02 21:10:16] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 02 21:10:16 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:16.271+09:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Jun 02 21:10:16 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:16.277+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:51172->127.0.0.1:3000: read: connection reset by peer" Jun 02 21:10:16 rivo systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 02 21:10:16 rivo sudo[9391]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:16 rivo sudo[7798]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:16 rivo qobuz-connect[8184]: 20260602 21:10:16.313 [8184.8184] INFO SampleApp: Socket closed Jun 02 21:10:16 rivo systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 02 21:10:16 rivo systemd[1]: Started dynamicswap service. Jun 02 21:10:16 rivo systemd[1]: dynamicswap.service: Succeeded. Jun 02 21:10:16 rivo systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 02 21:10:16 rivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jun 02 21:10:16 rivo systemd[1]: Stopped Volumio Backend Module. Jun 02 21:10:16 rivo systemd[1]: Started Volumio Backend Module. Jun 02 21:10:16 rivo systemd[1]: Started dynamicswap service. Jun 02 21:10:16 rivo systemd[1]: dynamicswap.service: Succeeded. Jun 02 21:10:17 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:17.279+09:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Jun 02 21:10:18 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:18.282+09:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Jun 02 21:10:19 rivo volumio[9617]: info: ------------------------------------------- Jun 02 21:10:19 rivo volumio[9617]: info: ----- Volumio3 ---- Jun 02 21:10:19 rivo volumio[9617]: info: ------------------------------------------- Jun 02 21:10:19 rivo volumio[9617]: info: ----- System startup ---- Jun 02 21:10:19 rivo volumio[9617]: info: ------------------------------------------- Jun 02 21:10:20 rivo volumio[9617]: info: MYVOLUMIO Environment detected Jun 02 21:10:21 rivo volumio[9617]: info: Plugin folders cleanup Jun 02 21:10:21 rivo volumio[9617]: info: Scanning into folder /volumio/app/plugins/ Jun 02 21:10:21 rivo volumio[9617]: info: Scanning category audio_interface Jun 02 21:10:21 rivo volumio[9617]: info: Scanning category miscellanea Jun 02 21:10:21 rivo volumio[9617]: info: Scanning category music_service Jun 02 21:10:21 rivo volumio[9617]: info: Scanning category plugins.json Jun 02 21:10:21 rivo volumio[9617]: info: Scanning category system_controller Jun 02 21:10:21 rivo volumio[9617]: info: Scanning category user_interface Jun 02 21:10:21 rivo volumio[9617]: info: Scanning into folder /data/plugins/ Jun 02 21:10:21 rivo volumio[9617]: info: Scanning category audio_interface Jun 02 21:10:21 rivo volumio[9617]: info: Plugin folders cleanup completed Jun 02 21:10:21 rivo volumio[9617]: info: ------------------------------------------- Jun 02 21:10:21 rivo volumio[9617]: info: ----- Core plugins startup ---- Jun 02 21:10:21 rivo volumio[9617]: info: ------------------------------------------- Jun 02 21:10:21 rivo volumio[9617]: info: Loading plugins from folder /volumio/app/plugins/ Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin bluetooth to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin multiroom to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin upnp to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin metavolumio to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin cd_controller to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin raat to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 02 21:10:21 rivo volumio[9617]: info: Loading plugins from folder /data/plugins/ Jun 02 21:10:21 rivo volumio[9617]: info: Loading plugin "system"... Jun 02 21:10:21 rivo volumio-remote-updater[2832]: [2026-06-02 21:10:21] [connect] Successful connection Jun 02 21:10:21 rivo volumio[9617]: info: Loading plugin "appearance"... Jun 02 21:10:22 rivo volumio[9617]: info: Loading plugin "network"... Jun 02 21:10:22 rivo volumio[9617]: info: Refreshing Cached IP Addresses Jun 02 21:10:22 rivo sudo[9649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 21:10:22 rivo sudo[9649]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:22 rivo sudo[9651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 21:10:22 rivo sudo[9651]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:22 rivo sudo[9649]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:22 rivo volumio[9617]: info: Loading plugin "services"... Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "volumio5onboarding"... Jun 02 21:10:23 rivo sudo[9651]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:23 rivo sudo[9661]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 02 21:10:23 rivo sudo[9661]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "alsa_controller"... Jun 02 21:10:23 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "wizard"... Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "networkfs"... Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo volumio[9617]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo volumio[9617]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Jun 02 21:10:23 rivo volumio[9617]: info: Starting Udev Watcher for removable devices Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo volumio[9617]: info: Ignoring mount for partition: BOOT Jun 02 21:10:23 rivo volumio[9617]: info: Ignoring mount for partition: volumio Jun 02 21:10:23 rivo volumio[9617]: info: Ignoring mount for partition: volumio_data Jun 02 21:10:23 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "volumio_command_line_client"... Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "upnp"... Jun 02 21:10:23 rivo volumio[9617]: info: [1780402223333] Starting Upmpd Daemon Jun 02 21:10:23 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "my_music"... Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "mpd"... Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo volumio[9617]: info: Loading plugin "upnp_browser"... Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:23 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:10:24 rivo volumio[9617]: info: Starting UPNP Browser Jun 02 21:10:24 rivo volumio[9617]: info: Plugin bluetooth is not enabled Jun 02 21:10:24 rivo volumio[9617]: info: Loading plugin "alarm-clock"... Jun 02 21:10:24 rivo volumio[9617]: info: Loading plugin "manifestui"... Jun 02 21:10:24 rivo volumio[9617]: info: Loading plugin "metavolumio"... Jun 02 21:10:26 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 0 Jun 02 21:10:26 rivo sudo[9661]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:26 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:26.556+09:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Jun 02 21:10:27 rivo volumio[9617]: info: Loading plugin "airplay_emulation"... Jun 02 21:10:27 rivo volumio[9617]: info: Starting Shairport Sync Jun 02 21:10:27 rivo volumio[9617]: info: Loading plugin "cd_controller"... Jun 02 21:10:27 rivo volumio[9617]: info: Loading plugin "last_100"... Jun 02 21:10:27 rivo volumio[9617]: info: Loading plugin "qobuzconnect"... Jun 02 21:10:27 rivo volumio[9617]: info: Loading plugin "raat"... Jun 02 21:10:28 rivo volumio[9617]: info: RAAT Plugin loaded Jun 02 21:10:28 rivo volumio[9617]: info: Adding restartRAATSocket REST API Endpoint Jun 02 21:10:28 rivo volumio[9617]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Jun 02 21:10:28 rivo volumio[9617]: info: Loading plugin "streaming_services"... Jun 02 21:10:29 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:29.284+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:51182->127.0.0.1:3000: i/o timeout" Jun 02 21:10:29 rivo volumio[9617]: info: Starting Streaming Service Transparent Proxy Jun 02 21:10:29 rivo volumio[9617]: info: Plugin tidalconnect is not enabled Jun 02 21:10:29 rivo volumio[9617]: info: Loading plugin "webradio"... Jun 02 21:10:30 rivo volumio[9617]: info: Loading plugin "i2s_dacs"... Jun 02 21:10:30 rivo volumio[9617]: info: I2S DAC not set, start Auto-detection Jun 02 21:10:30 rivo volumio[9617]: info: Loading plugin "volumiodiscovery"... Jun 02 21:10:30 rivo volumio[9617]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 21:10:30 rivo volumio[9617]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:10:30 rivo volumio[9617]: *** WARNING *** For more information see Jun 02 21:10:30 rivo node[9617]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 21:10:30 rivo volumio[9617]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 21:10:30 rivo volumio[9617]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:10:30 rivo volumio[9617]: *** WARNING *** For more information see Jun 02 21:10:30 rivo node[9617]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:10:30 rivo node[9617]: *** WARNING *** For more information see Jun 02 21:10:30 rivo node[9617]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 21:10:30 rivo node[9617]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:10:30 rivo node[9617]: *** WARNING *** For more information see Jun 02 21:10:30 rivo volumio[9617]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 02 21:10:30 rivo volumio[9617]: info: Discovery: Started advertising with name: Rivo Jun 02 21:10:30 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 21:10:30 rivo volumio[9617]: info: Loading plugin "multiroom"... Jun 02 21:10:31 rivo volumio[9617]: STREAMING PROXY: Starting server on port 3245 Jun 02 21:10:31 rivo volumio[9617]: Node JS runtime: 14 Jun 02 21:10:33 rivo volumio[9617]: info: Applying required configuration parameters for plugin multiroom Jun 02 21:10:33 rivo sudo[9733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 02 21:10:33 rivo sudo[9733]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:33 rivo sudo[9733]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:33 rivo volumio[9617]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Jun 02 21:10:33 rivo volumio[9617]: info: MRS: MultiRoom plugin initialized Jun 02 21:10:33 rivo volumio[9617]: info: MRS: STOPPING SNAPCLIENT Jun 02 21:10:33 rivo volumio[9617]: info: MRS: Snap server stop Jun 02 21:10:33 rivo sudo[9766]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 02 21:10:33 rivo sudo[9766]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:33 rivo volumio[9617]: info: MRS: STOPPING volumioStreaming Jun 02 21:10:33 rivo sudo[9768]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 02 21:10:33 rivo sudo[9768]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:33 rivo sudo[9766]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:33 rivo sudo[9772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 02 21:10:33 rivo volumio[9617]: info: Loading plugin "outputs"... Jun 02 21:10:33 rivo sudo[9772]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:33 rivo volumio[9617]: info: Loading plugin "albumart"... Jun 02 21:10:33 rivo sudo[9768]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:33 rivo sudo[9774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 02 21:10:33 rivo sudo[9774]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:33 rivo sudo[9774]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:33 rivo sudo[9772]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:33 rivo volumio[9617]: info: Plugin example_plugin is not enabled Jun 02 21:10:33 rivo volumio[9617]: info: Loading plugin "hi_res_audio"... Jun 02 21:10:33 rivo volumio-remote-updater[2832]: [2026-06-02 21:10:33] [connect] Successful connection Jun 02 21:10:33 rivo volumio[9617]: Forking 3 albumart workers Jun 02 21:10:35 rivo volumio[9617]: Starting albumart workers Jun 02 21:10:35 rivo volumio[9617]: Starting albumart workers Jun 02 21:10:35 rivo volumio[9617]: Starting albumart workers Jun 02 21:10:36 rivo volumio[9617]: info: Applying required configuration parameters for plugin hi_res_audio Jun 02 21:10:36 rivo volumio[9617]: info: Loading plugin "inputs"... Jun 02 21:10:36 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:36.555+09:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Jun 02 21:10:36 rivo volumio[9617]: info: Loading plugin "qobuz"... Jun 02 21:10:38 rivo volumio[9617]: info: Loading plugin "smart_inputs"... Jun 02 21:10:39 rivo volumio[9617]: info: Loading plugin "tidal"... Jun 02 21:10:40 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:40.287+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:51190->127.0.0.1:3000: i/o timeout" Jun 02 21:10:40 rivo volumio[9617]: info: Loading plugin "rivocontrol"... Jun 02 21:10:41 rivo volumio[9617]: info: Adding this device properties Jun 02 21:10:41 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Jun 02 21:10:41 rivo volumio[9617]: info: Setting Additional Device Volumio Properties: [object Object] Jun 02 21:10:41 rivo volumio[9617]: info: Loading plugin "updater_comm"... Jun 02 21:10:41 rivo volumio[9617]: info: Loading plugin "cec_controller"... Jun 02 21:10:42 rivo volumio[9617]: info: Applying required configuration parameters for plugin cec_controller Jun 02 21:10:42 rivo volumio[9617]: info: Plugin mpdemulation is not enabled Jun 02 21:10:42 rivo volumio[9617]: info: Loading plugin "rest_api"... Jun 02 21:10:42 rivo volumio[9617]: info: Loading plugin "websocket"... Jun 02 21:10:42 rivo volumio[9617]: info: Starting Socket.io Server version 2.3.0 Jun 02 21:10:42 rivo volumio[9617]: info: Loading plugin "fusiondsp"... Jun 02 21:10:42 rivo volumio[9617]: info: Applying required configuration parameters for plugin fusiondsp Jun 02 21:10:42 rivo volumio[9617]: info: Loading i18n strings for locale ja Jun 02 21:10:42 rivo volumio[9617]: Updating browse sources language Jun 02 21:10:42 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:10:42 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 21:10:42 rivo volumio[9617]: info: CoreCommandRouter::initPlayerControls Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: Express server listening on port 3000 Jun 02 21:10:43 rivo volumio[9617]: [Metrics] WebUI: 24s 268.55ms Jun 02 21:10:43 rivo volumio[9617]: info: CoreStateMachine::resetVolumioState Jun 02 21:10:43 rivo volumio[9617]: info: CoreStateMachine::getcurrentVolume Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 21:10:43 rivo volumio[9617]: info: CoreStateMachine::pushState Jun 02 21:10:43 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::volumioPushState Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:10:43 rivo volumio[9617]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Jun 02 21:10:43 rivo volumio[9617]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Jun 02 21:10:43 rivo sudo[9845]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 21:10:43 rivo sudo[9845]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:43 rivo sudo[9845]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:43 rivo volumio[9617]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 02 21:10:43 rivo volumio[9617]: info: Completed loading Core Plugins Jun 02 21:10:43 rivo sudo[9855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 21:10:43 rivo sudo[9855]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:43 rivo volumio[9617]: info: Preparing to generate the ALSA configuration file Jun 02 21:10:43 rivo sudo[9855]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:43 rivo volumio[9617]: info: Volumio Network Manager: Network status updated: 1 Jun 02 21:10:43 rivo volumio[9617]: info: MRS: Removed streaming files Jun 02 21:10:43 rivo volumio[9617]: info: MRS: volumioStreaming STOPPED Jun 02 21:10:43 rivo volumio[9617]: info: MRS: SNAPSERVER STOPPED Jun 02 21:10:43 rivo volumio[9617]: info: MRS: SNAPCLIENT STOPPED Jun 02 21:10:43 rivo volumio[9617]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 02 21:10:43 rivo volumio[9617]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 02 21:10:43 rivo volumio[9617]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 02 21:10:43 rivo volumio[9617]: info: Reading ALSA contributions from plugins. Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 5 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 8 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 10 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 12 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 13 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 14 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 15 Jun 02 21:10:43 rivo volumio[9617]: 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: 16 Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:10:43 rivo volumio[9617]: info: Discovery: Getting this device information Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:43 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:10:43 rivo volumio[9617]: info: Discovery: Getting this device information Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:43 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:43 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 17 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 18 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 19 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 20 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 21 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 22 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 23 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 24 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 25 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 26 Jun 02 21:10:43 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 27 Jun 02 21:10:43 rivo volumio[9617]: 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: 27 Jun 02 21:10:44 rivo volumio[9617]: info: Reloading queue from file Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 29 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 30 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 31 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 32 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 33 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 34 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 35 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 36 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 37 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 38 Jun 02 21:10:44 rivo volumio[9617]: info: CoreStateMachine::setRepeat null single undefined Jun 02 21:10:44 rivo volumio[9617]: info: CoreStateMachine::pushState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioPushState Jun 02 21:10:44 rivo volumio[9617]: info: CoreStateMachine::setRandom null Jun 02 21:10:44 rivo volumio[9617]: info: CoreStateMachine::pushState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioPushState Jun 02 21:10:44 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:44.174+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" state=STATUS_STOPPED positionMs=0 volume=100 Jun 02 21:10:44 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:44.175+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" id="music-library/NAS/music/坂本龍一/Opus/01 - 坂本龍一 - Lack of Love.flac" title="Lack of Love" Jun 02 21:10:44 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:44.177+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" state=STATUS_STOPPED positionMs=0 volume=100 Jun 02 21:10:44 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:44.177+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" id="music-library/NAS/music/坂本龍一/Opus/01 - 坂本龍一 - Lack of Love.flac" title="Lack of Love" Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:10:44 rivo volumio[9617]: info: Discovery: Getting this device information Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 39 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 40 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 41 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 42 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 43 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 44 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 45 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 46 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 47 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 48 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 49 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 50 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 51 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 52 Jun 02 21:10:44 rivo sudo[9867]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 02 21:10:44 rivo sudo[9867]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 53 Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201:3000 from 192.168.68.51 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 54 Jun 02 21:10:44 rivo sudo[9867]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: Received Get System Info Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:10:44 rivo volumio[9617]: info: Discovery: Getting this device information Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetQueue Jun 02 21:10:44 rivo volumio[9617]: info: CoreStateMachine::getQueue Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getQueue Jun 02 21:10:44 rivo volumio[9617]: info: Listing playlists Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 21:10:44 rivo volumio[9617]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 02 21:10:44 rivo volumio[9617]: info: Received Get System Info Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:10:44 rivo volumio[9617]: info: Discovery: Getting this device information Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:44 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 02 21:10:44 rivo volumio[9617]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 55 Jun 02 21:10:44 rivo volumio[9617]: info: Upmpdcli Daemon Started Jun 02 21:10:44 rivo volumio[9617]: info: Asound.conf file unchanged, so no further update is needed Jun 02 21:10:44 rivo volumio[9617]: info: Output device has changed, restarting MPD Jun 02 21:10:44 rivo sudo[9870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 21:10:44 rivo sudo[9870]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:44 rivo volumio[9617]: info: Output device has changed, restarting Shairport Sync Jun 02 21:10:44 rivo sudo[9870]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:10:44 rivo sudo[9873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 21:10:44 rivo sudo[9873]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:44 rivo systemd[1]: Stopping Music Player Daemon... Jun 02 21:10:44 rivo volumio[9617]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 21:10:44 rivo volumio[9617]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 02 21:10:44 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:45 rivo volumio[9617]: info: ___________ START PLUGINS ___________ Jun 02 21:10:45 rivo systemd[1]: mpd.service: Succeeded. Jun 02 21:10:45 rivo systemd[1]: Stopped Music Player Daemon. Jun 02 21:10:45 rivo systemd[1]: Starting Music Player Daemon... Jun 02 21:10:45 rivo volumio[9617]: info: ControllerMpd::onStart: Initializing MPD Jun 02 21:10:45 rivo volumio[9617]: info: Creating MPD Configuration file Jun 02 21:10:45 rivo sudo[9883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Jun 02 21:10:45 rivo sudo[9883]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 21:10:45 rivo volumio[9617]: info: [1780402245216] CoreMusicLibrary::Adding element DLNAサーバー Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:10:45 rivo sudo[9892]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 21:10:45 rivo sudo[9892]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:45 rivo sudo[9883]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:45 rivo sudo[9892]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:45 rivo volumio[9617]: info: UPNP Browser: Client initialized successfully Jun 02 21:10:45 rivo sudo[9895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 21:10:45 rivo sudo[9895]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:45 rivo volumio[9617]: info: Adding METAVOLUMIO REST API Endpoints Jun 02 21:10:45 rivo volumio[9617]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:10:45 rivo volumio[9617]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:10:45 rivo volumio[9617]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:10:45 rivo volumio[9617]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:10:45 rivo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 02 21:10:45 rivo systemd[1]: mpd.service: Succeeded. Jun 02 21:10:45 rivo systemd[1]: Stopped Music Player Daemon. Jun 02 21:10:45 rivo systemd[1]: Starting Music Player Daemon... Jun 02 21:10:45 rivo volumio[9617]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:10:45 rivo volumio[9617]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 21:10:45 rivo volumio[9617]: info: Preparing CD Folders Jun 02 21:10:45 rivo volumio[9617]: info: Adding CD REST API Endpoints Jun 02 21:10:45 rivo volumio[9617]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jun 02 21:10:45 rivo volumio[9617]: info: Starting UDEV Watcher for CD Jun 02 21:10:45 rivo volumio[9617]: info: Detecting CD presence with UDEV Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jun 02 21:10:45 rivo sudo[9901]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 02 21:10:45 rivo sudo[9901]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:45 rivo sudo[9901]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 21:10:45 rivo volumio[9617]: info: [1780402245649] CoreMusicLibrary::Adding element Last_100 Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:10:45 rivo volumio[9617]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jun 02 21:10:45 rivo volumio[9617]: info: QobuzConnect: Starting Qobuz Connect socket and service Jun 02 21:10:45 rivo volumio[9617]: info: Starting RAAT Plugin Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jun 02 21:10:45 rivo volumio[9617]: info: Additional UI Settings Added for plugin music_service/raat Jun 02 21:10:45 rivo volumio[9617]: info: Registering DSP Elements listener and retrieving current ones Jun 02 21:10:45 rivo volumio[9617]: info: Additional DSP elements updated Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:45 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:45 rivo volumio[9617]: info: Updating RAAT Signal Path Jun 02 21:10:45 rivo volumio[9617]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 02 21:10:45 rivo volumio[9617]: info: Streaming services startup Jun 02 21:10:45 rivo volumio[9617]: info: Starting Streaming Daemon Jun 02 21:10:45 rivo sudo[9911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 02 21:10:45 rivo sudo[9911]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:45 rivo sudo[9911]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:45 rivo sudo[9914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 02 21:10:45 rivo sudo[9914]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:45 rivo sudo[9915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 02 21:10:45 rivo sudo[9915]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:45 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 02 21:10:46 rivo qobuz-connect[8184]: 20260602 21:10:46.027 [8184.8184] INFO SampleApp: Stopping Local configuration server Jun 02 21:10:46 rivo sudo[9915]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:46 rivo volumio[9617]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 21:10:46 rivo volumio[9617]: info: [1780402246066] CoreMusicLibrary::Adding element Webradio Jun 02 21:10:46 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:10:46 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:10:46 rivo volumio[9617]: info: Initializing BBC Radios Jun 02 21:10:46 rivo systemd[1]: qobuz-connect.service: Succeeded. Jun 02 21:10:46 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 02 21:10:46 rivo systemd[1]: Started Volumio Qobuz Connect Service. Jun 02 21:10:46 rivo sudo[9914]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:46 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:10:46 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:10:46 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jun 02 21:10:46 rivo volumio[9617]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 02 21:10:46 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:46 rivo volumio[9617]: error: Hi Res Audio Failed Login: Missing Login Data Jun 02 21:10:46 rivo volumio[9617]: info: Adding HIGHRESAUDIO REST API Endpoints Jun 02 21:10:46 rivo volumio[9617]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 02 21:10:46 rivo volumio[9617]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 02 21:10:46 rivo volumio[9617]: info: Initializing Serial Communication on port /dev/ttyS3 Jun 02 21:10:46 rivo volumio[9617]: info: Touch Event Listener Process Starting Jun 02 21:10:46 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Jun 02 21:10:46 rivo volumio[9617]: info: Refreshing QOBUZ token Jun 02 21:10:46 rivo sudo[9942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Jun 02 21:10:46 rivo sudo[9942]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:46 rivo volumio[9617]: info: Adding inputs REST Endpoints Jun 02 21:10:46 rivo volumio[9617]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jun 02 21:10:46 rivo volumio[9617]: info: Scanning Audio Inputs Jun 02 21:10:46 rivo volumio[9617]: info: Checking against Known Cards name Jun 02 21:10:46 rivo volumio[9617]: info: Checking against Known Cards name Jun 02 21:10:46 rivo volumio[9617]: info: Checking against Known Cards name Jun 02 21:10:46 rivo volumio[9617]: info: Checking against Known Cards name Jun 02 21:10:46 rivo volumio[9617]: info: Checking against Known Cards name Jun 02 21:10:46 rivo volumio[9617]: info: Adding Server instance for streaming Jun 02 21:10:46 rivo sudo[9947]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Jun 02 21:10:46 rivo sudo[9947]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:46 rivo sudo[9947]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:46 rivo sudo[9950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Jun 02 21:10:46 rivo sudo[9950]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:46 rivo sudo[9950]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:46 rivo sudo[9953]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Jun 02 21:10:46 rivo sudo[9953]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:46 rivo sudo[9953]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:46 rivo sudo[9956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Jun 02 21:10:46 rivo sudo[9956]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:46 rivo sudo[9956]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:46 rivo volumio[9617]: info: Apply VIM3L Onboard LEDs Settings Jun 02 21:10:46 rivo volumio[9617]: info: Turning On Onboard LEDs Jun 02 21:10:47 rivo sudo[9960]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Jun 02 21:10:47 rivo sudo[9960]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:47 rivo volumio[9617]: info: Starting CEC Event listener Jun 02 21:10:47 rivo sudo[9960]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:47 rivo volumio[9617]: info: Loading i18n strings for locale ja Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:47 rivo volumio[9617]: info: FusionDsp - mixtype--------------------- None Jun 02 21:10:47 rivo sudo[9964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Jun 02 21:10:47 rivo sudo[9964]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:47 rivo volumio[9617]: info: Volumio Calling Home Jun 02 21:10:47 rivo sudo[9964]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:47 rivo volumio[9617]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jun 02 21:10:47 rivo volumio[9617]: (node:9617) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jun 02 21:10:47 rivo volumio[9617]: (Use `node --trace-deprecation ...` to show where the warning was created) Jun 02 21:10:47 rivo volumio[9617]: info: Preparing to generate the ALSA configuration file Jun 02 21:10:47 rivo volumio[9617]: info: Adding TIDAL REST API Endpoints Jun 02 21:10:47 rivo volumio[9617]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jun 02 21:10:47 rivo volumio[9617]: info: Discovery: adding 332105e0-0c22-4ae9-89b5-5575fbefbc30 Jun 02 21:10:47 rivo volumio[9617]: info: Discovery: Found device Rivo Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:47 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:47 rivo volumio[9617]: info: MRS: Pushing multiroomSync output for this device Jun 02 21:10:47 rivo volumio[9617]: info: MRS: Pushing multiroomSync output Jun 02 21:10:47 rivo volumio[9617]: info: Adding audio output: Jun 02 21:10:47 rivo volumio[9617]: info: Adding audio output: Jun 02 21:10:47 rivo volumio[9617]: info: Discovery: this is already registered, 332105e0-0c22-4ae9-89b5-5575fbefbc30 Jun 02 21:10:47 rivo volumio[9617]: info: Discovery: Found device Rivo Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:47 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:47 rivo volumio[9617]: info: Serial port opened successfully Jun 02 21:10:47 rivo volumio[9617]: info: Sending serial start messages Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:47 rivo volumio[9617]: info: Reporting MCU Network Status: 1 Jun 02 21:10:47 rivo volumio[9617]: info: MP1 GPIO: Signalled system ready via GPIO Jun 02 21:10:47 rivo volumio[9617]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 02 21:10:47 rivo volumio[9617]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 02 21:10:47 rivo volumio[9617]: info: Reading ALSA contributions from plugins. Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:47 rivo volumio[9617]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 55 Jun 02 21:10:47 rivo volumio[9617]: error: Cannot start Volumio Streaming Daemon Jun 02 21:10:47 rivo volumio[9617]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 02 21:10:47 rivo volumio[9617]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 02 21:10:47 rivo volumio[9617]: info: MPD Permissions set Jun 02 21:10:47 rivo volumio[9617]: info: MPD Permissions set Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Jun 02 21:10:47 rivo volumio[9617]: info: Setting Device Volume Override Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::volumioUpdateVolumeSettings Jun 02 21:10:47 rivo volumio[9617]: info: Updating Volume Controller Parameters: Device: 5 Name: VMV USB AUDIO Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Jun 02 21:10:47 rivo volumio[9617]: info: Disabling external Volume Control Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:47 rivo volumio[9617]: info: CoreStateMachine::pushState Jun 02 21:10:47 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::volumioPushState Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:47 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:47 rivo volumio[9617]: info: MRS: Pushing multiroomSync output update for this device Jun 02 21:10:47 rivo volumio[9617]: info: MRS: Pushing multiroomSync output Jun 02 21:10:47 rivo volumio[9617]: info: CoreStateMachine::pushState Jun 02 21:10:47 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::volumioPushState Jun 02 21:10:47 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:47 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:47 rivo volumio[9617]: info: MRS: Pushing multiroomSync output update for this device Jun 02 21:10:47 rivo volumio[9617]: info: MRS: Pushing multiroomSync output Jun 02 21:10:47 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:47.947+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" state=STATUS_STOPPED positionMs=0 volume=100 Jun 02 21:10:47 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:47.948+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" id="music-library/NAS/music/坂本龍一/Opus/01 - 坂本龍一 - Lack of Love.flac" title="Lack of Love" Jun 02 21:10:47 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:47.950+09:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" state=STATUS_STOPPED positionMs=0 volume=100 Jun 02 21:10:47 rivo volumio5-onboarding[4524]: time=2026-06-02T21:10:47.950+09:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" id="music-library/NAS/music/坂本龍一/Opus/01 - 坂本龍一 - Lack of Love.flac" title="Lack of Love" Jun 02 21:10:48 rivo volumio[9617]: info: Executing endpoint qc_getconfig Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.129 [9925.9925] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 02 21:10:48 rivo volumio[9617]: info: Volumio called home Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jun 02 21:10:48 rivo volumio[9617]: info: Setting Additional System Software info: Hardware Revision: 2.1 Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.152 [9925.9925] INFO VolumeManager: [0xaca58f50]: Setting new playback volume: 75 Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.152 [9925.9925] INFO VolumeManager: [0xaca58f50]: Setting new mute state: 0 Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.152 [9925.9925] INFO AudioStreamManager: [0xaca58ca8]: Setting new audio download buffer size: 1048576 Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.152 [9925.9925] INFO QobuzConnect: [0xaca59818]: Client initialized! Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.152 [9925.9925] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Jun 02 21:10:48 rivo volumio[9617]: info: Setting HW Firmware info: undefined Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jun 02 21:10:48 rivo volumio[9617]: info: Setting HW Version info: 2.1 Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Jun 02 21:10:48 rivo volumio[9617]: info: Setting Additional System Software info: Hardware Revision: 2.1, Firmware Version: 0.3.5 Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Jun 02 21:10:48 rivo volumio[9617]: info: Setting HW Firmware info: 0.3.5 Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Jun 02 21:10:48 rivo volumio[9617]: info: Setting HW Version info: 2.1 Jun 02 21:10:48 rivo volumio[9617]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Jun 02 21:10:48 rivo volumio[9617]: info: MCU Signalled Headphone Mode Disabled Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Jun 02 21:10:48 rivo volumio[9617]: info: Reporting Headphone State: false Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: Updating RAAT Signal Path Jun 02 21:10:48 rivo volumio[9617]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 02 21:10:48 rivo volumio[9617]: info: MCU Signalled Sleep Mode Disabled Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.186 [9925.9925] INFO LocalConfigManager: [0xaca589d0]: Starting Local Configuration server Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.186 [9925.9925] INFO SampleApp: Starting Local configuration server Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.187 [9925.9925] INFO SampleApp: Connected to UNIX socket client 0xaca4eed8 Jun 02 21:10:48 rivo volumio[9617]: info: Enabling Advanced system settings configuration Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Jun 02 21:10:48 rivo volumio[9617]: info: Additional UI Settings Added for plugin music_service/inputs Jun 02 21:10:48 rivo volumio[9617]: info: MCU Signalled Auto Boot Mode On Power Disabled Jun 02 21:10:48 rivo sudo[9980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Jun 02 21:10:48 rivo sudo[9980]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:48 rivo kernel: fb: osd[0] enable: 1 (Xorg) Jun 02 21:10:48 rivo sudo[9980]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:48 rivo qobuz-connect[9925]: 20260602 21:10:48.280 [9925.9925] INFO SampleApp: Playback volume changed: 75 Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:48 rivo volumio[9617]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 56 Jun 02 21:10:48 rivo volumio[9617]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 02 21:10:48 rivo volumio[9617]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 02 21:10:48 rivo volumio[9617]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds Jun 02 21:10:48 rivo volumio[9617]: info: Cannot mount NAS music at system boot, trial number 3 ,retrying in 5 seconds Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 02 21:10:48 rivo mpd[9906]: Jun 02 21:10 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:48 rivo volumio[9617]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Jun 02 21:10:48 rivo volumio-remote-updater[2832]: [2026-06-02 21:10:48] [connect] Successful connection Jun 02 21:10:48 rivo volumio[9617]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 57 Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::volumioGetState Jun 02 21:10:48 rivo volumio[9617]: info: CorePlayQueue::getTrack 0 Jun 02 21:10:48 rivo systemd[1]: Started Music Player Daemon. Jun 02 21:10:48 rivo sudo[9873]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:48 rivo sudo[9895]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:48 rivo volumio[9617]: info: MRS: Found cast device: AQUOS-4KTVJ25-1-0e9da59b63d143f07e0df78ceec50a58 Jun 02 21:10:48 rivo volumio[9617]: info: Adding audio output: Jun 02 21:10:48 rivo sudo[9995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Jun 02 21:10:48 rivo sudo[9995]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:48 rivo sudo[9995]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:48 rivo volumio[9617]: info: Access Token successfully retrieved Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 21:10:48 rivo volumio[9617]: info: [1780402248936] CoreMusicLibrary::Adding element QOBUZ Jun 02 21:10:48 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:10:48 rivo volumio[9617]: Cannot find translation for source QOBUZ Jun 02 21:10:48 rivo volumio[9617]: info: Stopping AccessToken refresher cron for QOBUZ Jun 02 21:10:49 rivo volumio[9617]: info: AccessToken refresher cron started for QOBUZ Jun 02 21:10:49 rivo volumio[9617]: info: Adding QOBUZ REST API Endpoints Jun 02 21:10:49 rivo volumio[9617]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jun 02 21:10:49 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:10:49 rivo volumio[9617]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 02 21:10:49 rivo volumio[9617]: 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 Jun 02 21:10:49 rivo volumio[9617]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 02 21:10:49 rivo volumio[9617]: info: camilladsp service started and running in background, instance 1 Jun 02 21:10:49 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:49 rivo volumio[9617]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 02 21:10:49 rivo volumio[9617]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 02 21:10:49 rivo volumio[9617]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 02 21:10:49 rivo volumio[9617]: info: FusionDsp loaded Jun 02 21:10:49 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:10:49 rivo sudo[10009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 02 21:10:49 rivo sudo[10009]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:49 rivo volumio[9617]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 02 21:10:49 rivo volumio[9617]: info: Adding Signal Path Element [object Object] Jun 02 21:10:49 rivo volumio[9617]: info: Adding fusiondspeq DSP Signal Path Element Jun 02 21:10:49 rivo volumio[9617]: info: Additional DSP elements updated Jun 02 21:10:49 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:49 rivo volumio[9617]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:10:49 rivo volumio[9617]: info: Updating RAAT Signal Path Jun 02 21:10:49 rivo volumio[9617]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 02 21:10:49 rivo volumio[9617]: info: FusionDsp - ---- installed callbackRead Jun 02 21:10:49 rivo volumio[9617]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:10:49 rivo systemd[1]: Started FusionDsp Daemon. Jun 02 21:10:49 rivo sudo[10009]: pam_unix(sudo:session): session closed for user root Jun 02 21:10:49 rivo volumio[9617]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 02 21:10:49 rivo volumio[9617]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jun 02 21:10:49 rivo volumio[9617]: at onErrorNT (internal/child_process.js:472:16) Jun 02 21:10:49 rivo volumio[9617]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 02 21:10:49 rivo volumio[9617]: at runNextTicks (internal/process/task_queues.js:64:3) Jun 02 21:10:49 rivo volumio[9617]: at listOnTimeout (internal/timers.js:526:9) Jun 02 21:10:49 rivo volumio[9617]: at processTimers (internal/timers.js:500:7) { Jun 02 21:10:49 rivo volumio[9617]: errno: -2, Jun 02 21:10:49 rivo volumio[9617]: code: 'ENOENT', Jun 02 21:10:49 rivo volumio[9617]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 02 21:10:49 rivo volumio[9617]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 02 21:10:49 rivo volumio[9617]: spawnargs: [ Jun 02 21:10:49 rivo volumio[9617]: '-p', Jun 02 21:10:49 rivo volumio[9617]: 9876, Jun 02 21:10:49 rivo volumio[9617]: '-o', Jun 02 21:10:49 rivo volumio[9617]: '/tmp/camilladsp.log', Jun 02 21:10:49 rivo volumio[9617]: '-l', Jun 02 21:10:49 rivo volumio[9617]: 'warn', Jun 02 21:10:49 rivo volumio[9617]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 02 21:10:49 rivo volumio[9617]: ] Jun 02 21:10:49 rivo volumio[9617]: } Jun 02 21:10:49 rivo volumio[9617]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:10:50 rivo sudo[10022]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 21:09 Jun 02 21:10:50 rivo sudo[10022]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:10:50 rivo sudo[10022]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:03 rivo volumio-remote-updater[2832]: [2026-06-02 21:11:03] [connect] Successful connection Jun 02 21:11:04 rivo volumio5-onboarding[4524]: time=2026-06-02T21:11:04.990+09:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Jun 02 21:11:05 rivo qobuz-connect[9925]: 20260602 21:11:04.995 [9925.9925] INFO SampleApp: Socket closed Jun 02 21:11:05 rivo systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 02 21:11:05 rivo volumio5-onboarding[4524]: time=2026-06-02T21:11:04.999+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:51240->127.0.0.1:3000: read: connection reset by peer" Jun 02 21:11:05 rivo volumio-remote-updater[2832]: [2026-06-02 21:11:04] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jun 02 21:11:05 rivo volumio-remote-updater[2832]: [2026-06-02 21:11:04] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jun 02 21:11:05 rivo volumio-remote-updater[2832]: [2026-06-02 21:11:04] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jun 02 21:11:05 rivo sudo[9942]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:05 rivo systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 02 21:11:05 rivo systemd[1]: Started dynamicswap service. Jun 02 21:11:05 rivo systemd[1]: dynamicswap.service: Succeeded. Jun 02 21:11:05 rivo systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 02 21:11:05 rivo systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jun 02 21:11:05 rivo systemd[1]: Started dynamicswap service. Jun 02 21:11:05 rivo systemd[1]: Stopped Volumio Backend Module. Jun 02 21:11:05 rivo systemd[1]: Started Volumio Backend Module. Jun 02 21:11:05 rivo systemd[1]: dynamicswap.service: Succeeded. Jun 02 21:11:06 rivo volumio5-onboarding[4524]: time=2026-06-02T21:11:06.001+09:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Jun 02 21:11:07 rivo volumio5-onboarding[4524]: time=2026-06-02T21:11:07.005+09:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Jun 02 21:11:07 rivo volumio[10080]: info: ------------------------------------------- Jun 02 21:11:07 rivo volumio[10080]: info: ----- Volumio3 ---- Jun 02 21:11:07 rivo volumio[10080]: info: ------------------------------------------- Jun 02 21:11:07 rivo volumio[10080]: info: ----- System startup ---- Jun 02 21:11:07 rivo volumio[10080]: info: ------------------------------------------- Jun 02 21:11:08 rivo volumio[10080]: info: MYVOLUMIO Environment detected Jun 02 21:11:08 rivo volumio[10080]: info: Plugin folders cleanup Jun 02 21:11:08 rivo volumio[10080]: info: Scanning into folder /volumio/app/plugins/ Jun 02 21:11:08 rivo volumio[10080]: info: Scanning category audio_interface Jun 02 21:11:08 rivo volumio[10080]: info: Scanning category miscellanea Jun 02 21:11:08 rivo volumio[10080]: info: Scanning category music_service Jun 02 21:11:08 rivo volumio[10080]: info: Scanning category plugins.json Jun 02 21:11:08 rivo volumio[10080]: info: Scanning category system_controller Jun 02 21:11:08 rivo volumio[10080]: info: Scanning category user_interface Jun 02 21:11:08 rivo volumio[10080]: info: Scanning into folder /data/plugins/ Jun 02 21:11:08 rivo volumio[10080]: info: Scanning category audio_interface Jun 02 21:11:08 rivo volumio[10080]: info: Plugin folders cleanup completed Jun 02 21:11:08 rivo volumio[10080]: info: ------------------------------------------- Jun 02 21:11:08 rivo volumio[10080]: info: ----- Core plugins startup ---- Jun 02 21:11:08 rivo volumio[10080]: info: ------------------------------------------- Jun 02 21:11:08 rivo volumio[10080]: info: Loading plugins from folder /volumio/app/plugins/ Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin bluetooth to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin multiroom to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin upnp to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin metavolumio to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin cd_controller to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin raat to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 02 21:11:08 rivo volumio[10080]: info: Loading plugins from folder /data/plugins/ Jun 02 21:11:08 rivo volumio[10080]: info: Loading plugin "system"... Jun 02 21:11:08 rivo volumio[10080]: info: Loading plugin "appearance"... Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "network"... Jun 02 21:11:10 rivo volumio[10080]: info: Refreshing Cached IP Addresses Jun 02 21:11:10 rivo sudo[10107]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 21:11:10 rivo sudo[10107]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:10 rivo sudo[10109]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 21:11:10 rivo sudo[10109]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:10 rivo sudo[10107]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:10 rivo sudo[10109]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "services"... Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "volumio5onboarding"... Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "alsa_controller"... Jun 02 21:11:10 rivo sudo[10121]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 02 21:11:10 rivo sudo[10121]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:10 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "wizard"... Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "networkfs"... Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo volumio[10080]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Jun 02 21:11:10 rivo volumio[10080]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds Jun 02 21:11:10 rivo volumio[10080]: info: Starting Udev Watcher for removable devices Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:10 rivo volumio[10080]: info: Ignoring mount for partition: BOOT Jun 02 21:11:10 rivo volumio[10080]: info: Ignoring mount for partition: volumio Jun 02 21:11:10 rivo volumio[10080]: info: Ignoring mount for partition: volumio_data Jun 02 21:11:10 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "volumio_command_line_client"... Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "upnp"... Jun 02 21:11:10 rivo volumio[10080]: info: [1780402270603] Starting Upmpd Daemon Jun 02 21:11:10 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "my_music"... Jun 02 21:11:10 rivo volumio[10080]: info: Loading plugin "mpd"... Jun 02 21:11:11 rivo volumio[10080]: info: Loading plugin "upnp_browser"... Jun 02 21:11:11 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:11 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:11 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:11 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:11 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 8 Jun 02 21:11:11 rivo volumio[10080]: info: Starting UPNP Browser Jun 02 21:11:11 rivo volumio[10080]: info: Plugin bluetooth is not enabled Jun 02 21:11:11 rivo volumio[10080]: info: Loading plugin "alarm-clock"... Jun 02 21:11:11 rivo volumio[10080]: info: Loading plugin "manifestui"... Jun 02 21:11:11 rivo volumio[10080]: info: Loading plugin "metavolumio"... Jun 02 21:11:13 rivo volumio[10080]: info: Loading plugin "airplay_emulation"... Jun 02 21:11:13 rivo volumio[10080]: info: Starting Shairport Sync Jun 02 21:11:13 rivo volumio[10080]: info: Loading plugin "cd_controller"... Jun 02 21:11:13 rivo kernel: CFG80211-ERROR) wl_escan_handler : escan is not ready ndev ffffffc04eb95000 drv_status 0x0 e_type 69 e_states 0 Jun 02 21:11:13 rivo sudo[10121]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:13 rivo volumio[10080]: info: Loading plugin "last_100"... Jun 02 21:11:13 rivo volumio[10080]: info: Loading plugin "qobuzconnect"... Jun 02 21:11:13 rivo volumio[10080]: info: Loading plugin "raat"... Jun 02 21:11:13 rivo volumio[10080]: info: RAAT Plugin loaded Jun 02 21:11:13 rivo volumio[10080]: info: Adding restartRAATSocket REST API Endpoint Jun 02 21:11:13 rivo volumio[10080]: info: Adding restartRAATSocket REST Endpoint for plugin: music_service/raat Jun 02 21:11:13 rivo volumio[10080]: info: Loading plugin "streaming_services"... Jun 02 21:11:13 rivo volumio5-onboarding[4524]: time=2026-06-02T21:11:13.869+09:00 level=INFO msg="emitting wifi info changed event" component=server peer="192.168.68.51:54984 @ 0x314c600" available=true connected=false macAddress= ip4Address= ip6Address= ssid= Jun 02 21:11:15 rivo volumio-remote-updater[2832]: [2026-06-02 21:11:14] [connect] Successful connection Jun 02 21:11:15 rivo volumio[10080]: info: Starting Streaming Service Transparent Proxy Jun 02 21:11:15 rivo volumio[10080]: info: Plugin tidalconnect is not enabled Jun 02 21:11:15 rivo volumio[10080]: info: Loading plugin "webradio"... Jun 02 21:11:15 rivo volumio[10080]: info: Loading plugin "i2s_dacs"... Jun 02 21:11:15 rivo volumio[10080]: info: I2S DAC not set, start Auto-detection Jun 02 21:11:15 rivo volumio[10080]: info: Loading plugin "volumiodiscovery"... Jun 02 21:11:15 rivo volumio[10080]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 21:11:15 rivo volumio[10080]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:11:15 rivo node[10080]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 02 21:11:15 rivo volumio[10080]: *** WARNING *** For more information see Jun 02 21:11:15 rivo volumio[10080]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 21:11:15 rivo volumio[10080]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:11:15 rivo volumio[10080]: *** WARNING *** For more information see Jun 02 21:11:15 rivo node[10080]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:11:15 rivo node[10080]: *** WARNING *** For more information see Jun 02 21:11:15 rivo volumio[10080]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 02 21:11:15 rivo node[10080]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 02 21:11:15 rivo node[10080]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 02 21:11:15 rivo node[10080]: *** WARNING *** For more information see Jun 02 21:11:15 rivo volumio[10080]: info: Discovery: Started advertising with name: Rivo Jun 02 21:11:15 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 02 21:11:15 rivo volumio[10080]: info: Loading plugin "multiroom"... Jun 02 21:11:16 rivo volumio[10080]: STREAMING PROXY: Starting server on port 3245 Jun 02 21:11:16 rivo volumio[10080]: Node JS runtime: 14 Jun 02 21:11:17 rivo volumio[10080]: info: Applying required configuration parameters for plugin multiroom Jun 02 21:11:17 rivo sudo[10151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 02 21:11:17 rivo sudo[10151]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:17 rivo sudo[10151]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:17 rivo volumio[10080]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Jun 02 21:11:17 rivo volumio[10080]: info: MRS: MultiRoom plugin initialized Jun 02 21:11:17 rivo volumio[10080]: info: MRS: STOPPING SNAPCLIENT Jun 02 21:11:17 rivo volumio[10080]: info: MRS: Snap server stop Jun 02 21:11:17 rivo sudo[10167]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 02 21:11:17 rivo sudo[10167]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:17 rivo volumio[10080]: info: MRS: STOPPING volumioStreaming Jun 02 21:11:17 rivo sudo[10170]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 02 21:11:17 rivo sudo[10170]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:17 rivo sudo[10167]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:17 rivo volumio[10080]: info: Loading plugin "outputs"... Jun 02 21:11:17 rivo sudo[10173]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 02 21:11:17 rivo sudo[10173]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:17 rivo volumio[10080]: info: Loading plugin "albumart"... Jun 02 21:11:17 rivo sudo[10170]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:17 rivo sudo[10175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 02 21:11:17 rivo sudo[10175]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:17 rivo sudo[10175]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:17 rivo volumio[10080]: info: Plugin example_plugin is not enabled Jun 02 21:11:17 rivo volumio[10080]: info: Loading plugin "hi_res_audio"... Jun 02 21:11:17 rivo sudo[10173]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:18 rivo volumio5-onboarding[4524]: time=2026-06-02T21:11:18.007+09:00 level=WARN msg="reconnection attempt failed" error="read tcp 127.0.0.1:51248->127.0.0.1:3000: i/o timeout" Jun 02 21:11:18 rivo volumio[10080]: Forking 3 albumart workers Jun 02 21:11:19 rivo volumio[10080]: Starting albumart workers Jun 02 21:11:19 rivo volumio[10080]: Starting albumart workers Jun 02 21:11:19 rivo volumio[10080]: Starting albumart workers Jun 02 21:11:19 rivo volumio[10080]: info: Applying required configuration parameters for plugin hi_res_audio Jun 02 21:11:19 rivo volumio[10080]: info: Loading plugin "inputs"... Jun 02 21:11:20 rivo volumio[10080]: info: Loading plugin "qobuz"... Jun 02 21:11:22 rivo volumio[10080]: info: Loading plugin "smart_inputs"... Jun 02 21:11:22 rivo volumio[10080]: info: Loading plugin "tidal"... Jun 02 21:11:23 rivo volumio[10080]: info: Loading plugin "rivocontrol"... Jun 02 21:11:23 rivo volumio[10080]: info: Adding this device properties Jun 02 21:11:23 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Jun 02 21:11:23 rivo volumio[10080]: info: Setting Additional Device Volumio Properties: [object Object] Jun 02 21:11:23 rivo volumio[10080]: info: Loading plugin "updater_comm"... Jun 02 21:11:23 rivo volumio5-onboarding[4524]: time=2026-06-02T21:11:23.867+09:00 level=ERROR msg="failed to update discovery on Wi-Fi info change" error="failed to get system info: could not get system info: context deadline exceeded" Jun 02 21:11:24 rivo volumio[10080]: info: Loading plugin "cec_controller"... Jun 02 21:11:24 rivo volumio[10080]: info: Applying required configuration parameters for plugin cec_controller Jun 02 21:11:24 rivo volumio[10080]: info: Plugin mpdemulation is not enabled Jun 02 21:11:24 rivo volumio[10080]: info: Loading plugin "rest_api"... Jun 02 21:11:24 rivo volumio[10080]: info: Loading plugin "websocket"... Jun 02 21:11:24 rivo volumio[10080]: info: Starting Socket.io Server version 2.3.0 Jun 02 21:11:24 rivo volumio[10080]: info: Loading plugin "fusiondsp"... Jun 02 21:11:24 rivo volumio[10080]: info: Applying required configuration parameters for plugin fusiondsp Jun 02 21:11:24 rivo volumio[10080]: info: Loading i18n strings for locale ja Jun 02 21:11:24 rivo volumio[10080]: Updating browse sources language Jun 02 21:11:24 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::initPlayerControls Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: Express server listening on port 3000 Jun 02 21:11:25 rivo volumio[10080]: [Metrics] WebUI: 17s 966.17ms Jun 02 21:11:25 rivo volumio[10080]: info: CoreStateMachine::resetVolumioState Jun 02 21:11:25 rivo volumio[10080]: info: CoreStateMachine::getcurrentVolume Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::volumioRetrievevolume Jun 02 21:11:25 rivo volumio[10080]: info: CoreStateMachine::pushState Jun 02 21:11:25 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::volumioPushState Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:11:25 rivo volumio[10080]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Jun 02 21:11:25 rivo volumio[10080]: info: Cannot mount NAS music at system boot, trial number 2 ,retrying in 5 seconds Jun 02 21:11:25 rivo sudo[10293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 02 21:11:25 rivo sudo[10293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:25 rivo sudo[10293]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:25 rivo volumio[10080]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 02 21:11:25 rivo volumio[10080]: info: Completed loading Core Plugins Jun 02 21:11:25 rivo volumio[10080]: info: Preparing to generate the ALSA configuration file Jun 02 21:11:25 rivo sudo[10297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 02 21:11:25 rivo sudo[10297]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:25 rivo sudo[10297]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:25 rivo volumio[10080]: info: Volumio Network Manager: Network status updated: 1 Jun 02 21:11:25 rivo volumio[10080]: info: MRS: Removed streaming files Jun 02 21:11:25 rivo volumio[10080]: info: MRS: volumioStreaming STOPPED Jun 02 21:11:25 rivo volumio[10080]: info: MRS: SNAPSERVER STOPPED Jun 02 21:11:25 rivo volumio[10080]: info: MRS: SNAPCLIENT STOPPED Jun 02 21:11:25 rivo volumio[10080]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jun 02 21:11:25 rivo volumio[10080]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 02 21:11:25 rivo volumio[10080]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 02 21:11:25 rivo volumio[10080]: info: Reading ALSA contributions from plugins. Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 2 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 3 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 4 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 7 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 9 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 10 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 11 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 12 Jun 02 21:11:25 rivo volumio[10080]: 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: 13 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 13 Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:11:25 rivo volumio[10080]: info: Discovery: Getting this device information Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:25 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:11:25 rivo volumio[10080]: info: Discovery: Getting this device information Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:25 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:25 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 14 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 15 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 16 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 17 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 18 Jun 02 21:11:25 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 19 Jun 02 21:11:25 rivo volumio[10080]: info: Reloading queue from file Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 20 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 21 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 22 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 23 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 24 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 25 Jun 02 21:11:26 rivo volumio[10080]: 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: 26 Jun 02 21:11:26 rivo volumio[10080]: info: CoreStateMachine::setRepeat null single undefined Jun 02 21:11:26 rivo volumio[10080]: info: CoreStateMachine::pushState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioPushState Jun 02 21:11:26 rivo volumio[10080]: info: CoreStateMachine::setRandom null Jun 02 21:11:26 rivo volumio[10080]: info: CoreStateMachine::pushState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioPushState Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 26 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.200 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/149.0.0.0 Safari/537.36 Edg/149.0.0.0 Engine version: 3 Transport: polling Total Clients: 27 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201 from 192.168.68.51 UA: Mozilla/5.0 (Linux; Android 17; Build/CP31.260508.005; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/149.0.7827.48 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 28 Jun 02 21:11:26 rivo volumio[10080]: verbose: New Socket.io Connection to 192.168.68.201:3000 from 192.168.68.51 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 29 Jun 02 21:11:26 rivo volumio[10080]: 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: 30 Jun 02 21:11:26 rivo sudo[10308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 02 21:11:26 rivo sudo[10308]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:26 rivo sudo[10308]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:26 rivo volumio[10080]: info: Received Get System Info Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:11:26 rivo volumio[10080]: info: Discovery: Getting this device information Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetQueue Jun 02 21:11:26 rivo volumio[10080]: info: CoreStateMachine::getQueue Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getQueue Jun 02 21:11:26 rivo volumio[10080]: info: Listing playlists Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 21:11:26 rivo volumio[10080]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 02 21:11:26 rivo volumio[10080]: info: Received Get System Info Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:11:26 rivo volumio[10080]: info: Discovery: Getting this device information Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 02 21:11:26 rivo volumio[10080]: 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: 30 Jun 02 21:11:26 rivo volumio[10080]: info: Upmpdcli Daemon Started Jun 02 21:11:26 rivo volumio[10080]: info: Discovery: adding 332105e0-0c22-4ae9-89b5-5575fbefbc30 Jun 02 21:11:26 rivo volumio[10080]: info: Discovery: Found device Rivo Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: MRS: Pushing multiroomSync output for this device Jun 02 21:11:26 rivo volumio[10080]: info: MRS: Pushing multiroomSync output Jun 02 21:11:26 rivo volumio[10080]: info: Adding audio output: Jun 02 21:11:26 rivo volumio[10080]: info: Adding audio output: Jun 02 21:11:26 rivo volumio[10080]: info: Discovery: this is already registered, 332105e0-0c22-4ae9-89b5-5575fbefbc30 Jun 02 21:11:26 rivo volumio[10080]: info: Discovery: Found device Rivo Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::volumioGetState Jun 02 21:11:26 rivo volumio[10080]: info: CorePlayQueue::getTrack 0 Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:11:26 rivo volumio[10080]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:11:26 rivo volumio[10080]: 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: 29 Jun 02 21:11:26 rivo volumio[10080]: 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: 29 Jun 02 21:11:26 rivo volumio[10080]: info: Asound.conf file written Jun 02 21:11:26 rivo sudo[10312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jun 02 21:11:26 rivo sudo[10312]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:26 rivo sudo[10312]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:27 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Jun 02 21:11:27 rivo kernel: Err: can not set rate to 4262967296! Jun 02 21:11:27 rivo kernel: Range[3920000 - 500000000] Jun 02 21:11:27 rivo kernel: out of value, fixed it Jun 02 21:11:27 rivo kernel: id=0 set inskew=0 Jun 02 21:11:27 rivo volumio[10080]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Jun 02 21:11:27 rivo volumio[10080]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Jun 02 21:11:27 rivo volumio[10080]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Jun 02 21:11:27 rivo volumio[10080]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Jun 02 21:11:27 rivo volumio[10080]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:VMV Internal Clock Validity:0' : Operation not permitted Jun 02 21:11:27 rivo volumio[10080]: info: Output device has changed, restarting MPD Jun 02 21:11:27 rivo sudo[10317]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 21:11:27 rivo sudo[10317]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo sudo[10317]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:27 rivo volumio[10080]: info: Output device has changed, restarting Shairport Sync Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:11:27 rivo sudo[10320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 21:11:27 rivo sudo[10320]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo systemd[1]: Stopping Music Player Daemon... Jun 02 21:11:27 rivo volumio[10080]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 21:11:27 rivo volumio[10080]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: ___________ START PLUGINS ___________ Jun 02 21:11:27 rivo systemd[1]: mpd.service: Succeeded. Jun 02 21:11:27 rivo systemd[1]: Stopped Music Player Daemon. Jun 02 21:11:27 rivo systemd[1]: Starting Music Player Daemon... Jun 02 21:11:27 rivo volumio[10080]: info: ControllerMpd::onStart: Initializing MPD Jun 02 21:11:27 rivo volumio[10080]: info: Creating MPD Configuration file Jun 02 21:11:27 rivo sudo[10328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Jun 02 21:11:27 rivo sudo[10328]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo sudo[10334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 02 21:11:27 rivo sudo[10334]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 21:11:27 rivo volumio[10080]: info: [1780402287361] CoreMusicLibrary::Adding element DLNAサーバー Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:11:27 rivo sudo[10328]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:27 rivo sudo[10334]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:27 rivo volumio[10080]: info: UPNP Browser: Client initialized successfully Jun 02 21:11:27 rivo sudo[10340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 02 21:11:27 rivo sudo[10340]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo volumio[10080]: info: Adding METAVOLUMIO REST API Endpoints Jun 02 21:11:27 rivo volumio[10080]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:11:27 rivo volumio[10080]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:11:27 rivo volumio[10080]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:11:27 rivo volumio[10080]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:11:27 rivo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 02 21:11:27 rivo systemd[1]: mpd.service: Succeeded. Jun 02 21:11:27 rivo systemd[1]: Stopped Music Player Daemon. Jun 02 21:11:27 rivo systemd[1]: Starting Music Player Daemon... Jun 02 21:11:27 rivo volumio[10080]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 02 21:11:27 rivo volumio[10080]: info: Preparing CD Folders Jun 02 21:11:27 rivo volumio[10080]: info: Adding CD REST API Endpoints Jun 02 21:11:27 rivo volumio[10080]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jun 02 21:11:27 rivo volumio[10080]: info: Starting UDEV Watcher for CD Jun 02 21:11:27 rivo volumio[10080]: info: Detecting CD presence with UDEV Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 21:11:27 rivo volumio[10080]: info: [1780402287632] CoreMusicLibrary::Adding element Last_100 Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:11:27 rivo volumio[10080]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jun 02 21:11:27 rivo sudo[10345]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 02 21:11:27 rivo sudo[10345]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo sudo[10345]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:27 rivo volumio[10080]: info: QobuzConnect: Starting Qobuz Connect socket and service Jun 02 21:11:27 rivo volumio[10080]: info: Starting RAAT Plugin Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Jun 02 21:11:27 rivo volumio[10080]: info: Additional UI Settings Added for plugin music_service/raat Jun 02 21:11:27 rivo volumio[10080]: info: Registering DSP Elements listener and retrieving current ones Jun 02 21:11:27 rivo volumio[10080]: info: Additional DSP elements updated Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:27 rivo volumio[10080]: info: Updating RAAT Signal Path Jun 02 21:11:27 rivo volumio[10080]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 02 21:11:27 rivo volumio[10080]: info: Streaming services startup Jun 02 21:11:27 rivo volumio[10080]: info: Starting Streaming Daemon Jun 02 21:11:27 rivo sudo[10356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 02 21:11:27 rivo sudo[10356]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo sudo[10356]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:27 rivo sudo[10359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 02 21:11:27 rivo sudo[10359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo sudo[10361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 02 21:11:27 rivo sudo[10361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:27 rivo sudo[10359]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:27 rivo systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 02 21:11:27 rivo qobuz-connect[9925]: 20260602 21:11:27.857 [9925.9925] INFO SampleApp: Stopping Local configuration server Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 02 21:11:27 rivo volumio[10080]: info: [1780402287869] CoreMusicLibrary::Adding element Webradio Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:11:27 rivo systemd[1]: qobuz-connect.service: Succeeded. Jun 02 21:11:27 rivo systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 02 21:11:27 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:11:27 rivo volumio[10080]: info: Initializing BBC Radios Jun 02 21:11:27 rivo systemd[1]: Started Volumio Qobuz Connect Service. Jun 02 21:11:27 rivo sudo[10361]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:28 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:11:28 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 02 21:11:28 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jun 02 21:11:28 rivo volumio[10080]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 02 21:11:28 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:28 rivo volumio[10080]: error: Hi Res Audio Failed Login: Missing Login Data Jun 02 21:11:28 rivo volumio[10080]: info: Adding HIGHRESAUDIO REST API Endpoints Jun 02 21:11:28 rivo volumio[10080]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 02 21:11:28 rivo volumio[10080]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 02 21:11:28 rivo volumio[10080]: info: Initializing Serial Communication on port /dev/ttyS3 Jun 02 21:11:28 rivo kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 115200 to 115200 Jun 02 21:11:28 rivo volumio[10080]: info: Touch Event Listener Process Starting Jun 02 21:11:28 rivo volumio[10080]: info: Refreshing QOBUZ token Jun 02 21:11:28 rivo sudo[10389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Jun 02 21:11:28 rivo sudo[10389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:28 rivo volumio[10080]: info: Adding inputs REST Endpoints Jun 02 21:11:28 rivo volumio[10080]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jun 02 21:11:28 rivo volumio[10080]: info: Scanning Audio Inputs Jun 02 21:11:28 rivo volumio[10080]: info: Checking against Known Cards name Jun 02 21:11:28 rivo volumio[10080]: info: Checking against Known Cards name Jun 02 21:11:28 rivo volumio[10080]: info: Checking against Known Cards name Jun 02 21:11:28 rivo volumio[10080]: info: Checking against Known Cards name Jun 02 21:11:28 rivo volumio[10080]: info: Checking against Known Cards name Jun 02 21:11:28 rivo volumio[10080]: info: Adding Server instance for streaming Jun 02 21:11:28 rivo sudo[10394]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Jun 02 21:11:28 rivo sudo[10394]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:28 rivo sudo[10394]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:28 rivo sudo[10397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Jun 02 21:11:28 rivo sudo[10397]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:28 rivo sudo[10397]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:28 rivo sudo[10400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Jun 02 21:11:28 rivo sudo[10400]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:28 rivo sudo[10400]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:28 rivo sudo[10403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Jun 02 21:11:28 rivo sudo[10403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:28 rivo sudo[10403]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:28 rivo volumio[10080]: info: Apply VIM3L Onboard LEDs Settings Jun 02 21:11:28 rivo volumio[10080]: info: Turning On Onboard LEDs Jun 02 21:11:28 rivo sudo[10407]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Jun 02 21:11:28 rivo sudo[10407]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:28 rivo sudo[10407]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:28 rivo volumio[10080]: info: Starting CEC Event listener Jun 02 21:11:28 rivo volumio[10080]: info: Loading i18n strings for locale ja Jun 02 21:11:28 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 02 21:11:28 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:28 rivo volumio[10080]: info: FusionDsp - mixtype--------------------- None Jun 02 21:11:28 rivo sudo[10411]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Jun 02 21:11:28 rivo sudo[10411]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:28 rivo volumio[10080]: info: Volumio Calling Home Jun 02 21:11:28 rivo sudo[10411]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:29 rivo volumio[10080]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jun 02 21:11:29 rivo volumio[10080]: (node:10080) [DEP0005] DeprecationWarning: Buffer() is deprecated due to security and usability issues. Please use the Buffer.alloc(), Buffer.allocUnsafe(), or Buffer.from() methods instead. Jun 02 21:11:29 rivo volumio[10080]: (Use `node --trace-deprecation ...` to show where the warning was created) Jun 02 21:11:29 rivo volumio[10080]: info: Preparing to generate the ALSA configuration file Jun 02 21:11:29 rivo volumio[10080]: info: Adding TIDAL REST API Endpoints Jun 02 21:11:29 rivo volumio[10080]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Jun 02 21:11:29 rivo volumio[10080]: info: Serial port opened successfully Jun 02 21:11:29 rivo volumio[10080]: info: Sending serial start messages Jun 02 21:11:29 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:29 rivo volumio[10080]: info: Reporting MCU Network Status: 1 Jun 02 21:11:29 rivo volumio[10080]: info: MP1 GPIO: Signalled system ready via GPIO Jun 02 21:11:29 rivo volumio[10080]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 02 21:11:29 rivo volumio[10080]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 02 21:11:29 rivo volumio[10080]: info: Reading ALSA contributions from plugins. Jun 02 21:11:29 rivo volumio[10080]: info: FusionDsp - no preset used Jun 02 21:11:29 rivo volumio[10080]: info: FusionDsp - no preset used Jun 02 21:11:30 rivo volumio-remote-updater[2832]: [2026-06-02 21:11:30] [connect] Successful connection Jun 02 21:11:30 rivo volumio[10080]: info: FusionDsp - no preset used Jun 02 21:11:30 rivo volumio[10080]: info: FusionDsp - no preset used Jun 02 21:11:30 rivo mpd[10354]: Jun 02 21:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:11:30 rivo volumio[10080]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 29 Jun 02 21:11:30 rivo volumio[10080]: 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: 30 Jun 02 21:11:30 rivo volumio[10080]: info: Executing endpoint qc_getconfig Jun 02 21:11:30 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.928 [10368.10368] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.939 [10368.10368] INFO VolumeManager: [0xab4ebf50]: Setting new playback volume: 75 Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.940 [10368.10368] INFO VolumeManager: [0xab4ebf50]: Setting new mute state: 0 Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.940 [10368.10368] INFO AudioStreamManager: [0xab4ebca8]: Setting new audio download buffer size: 1048576 Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.941 [10368.10368] INFO QobuzConnect: [0xab4ec818]: Client initialized! Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.941 [10368.10368] INFO SampleApp: Starting Avahi advertising, name: Rivo, service name: _qobuz-connect._tcp Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.960 [10368.10368] INFO LocalConfigManager: [0xab4eb9d0]: Starting Local Configuration server Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.960 [10368.10368] INFO SampleApp: Starting Local configuration server Jun 02 21:11:30 rivo qobuz-connect[10368]: 20260602 21:11:30.961 [10368.10368] INFO SampleApp: Connected to UNIX socket client 0xab4e1ed8 Jun 02 21:11:30 rivo volumio[10080]: error: Cannot start Volumio Streaming Daemon Jun 02 21:11:30 rivo volumio[10080]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 02 21:11:30 rivo volumio[10080]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 02 21:11:30 rivo volumio[10080]: info: MPD Permissions set Jun 02 21:11:31 rivo volumio[10080]: info: MPD Permissions set Jun 02 21:11:31 rivo systemd[1]: Started Music Player Daemon. Jun 02 21:11:31 rivo sudo[10340]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:31 rivo sudo[10320]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:31 rivo qobuz-connect[10368]: 20260602 21:11:31.077 [10368.10368] INFO SampleApp: Playback volume changed: 75 Jun 02 21:11:31 rivo volumio[10080]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 02 21:11:31 rivo volumio[10080]: 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 Jun 02 21:11:31 rivo volumio[10080]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 02 21:11:31 rivo volumio[10080]: info: camilladsp service started and running in background, instance 1 Jun 02 21:11:31 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:31 rivo volumio[10080]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 02 21:11:31 rivo volumio[10080]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 02 21:11:31 rivo volumio[10080]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 02 21:11:31 rivo volumio[10080]: info: FusionDsp loaded Jun 02 21:11:31 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:11:31 rivo sudo[10453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 02 21:11:31 rivo sudo[10453]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 02 21:11:31 rivo volumio[10080]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 02 21:11:31 rivo volumio[10080]: info: Adding Signal Path Element [object Object] Jun 02 21:11:31 rivo volumio[10080]: info: Adding fusiondspeq DSP Signal Path Element Jun 02 21:11:31 rivo volumio[10080]: info: Additional DSP elements updated Jun 02 21:11:31 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:31 rivo volumio[10080]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 02 21:11:31 rivo volumio[10080]: info: Updating RAAT Signal Path Jun 02 21:11:31 rivo volumio[10080]: error: Cannot write to RAAT Client: TypeError: Cannot read property 'write' of undefined Jun 02 21:11:31 rivo volumio[10080]: info: FusionDsp - ---- installed callbackRead Jun 02 21:11:31 rivo volumio[10080]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:11:31 rivo volumio[10080]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 02 21:11:31 rivo volumio[10080]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jun 02 21:11:31 rivo volumio[10080]: at onErrorNT (internal/child_process.js:472:16) Jun 02 21:11:31 rivo volumio[10080]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jun 02 21:11:31 rivo volumio[10080]: at runNextTicks (internal/process/task_queues.js:64:3) Jun 02 21:11:31 rivo volumio[10080]: at listOnTimeout (internal/timers.js:526:9) Jun 02 21:11:31 rivo volumio[10080]: at processTimers (internal/timers.js:500:7) { Jun 02 21:11:31 rivo volumio[10080]: errno: -2, Jun 02 21:11:31 rivo volumio[10080]: code: 'ENOENT', Jun 02 21:11:31 rivo volumio[10080]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 02 21:11:31 rivo volumio[10080]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 02 21:11:31 rivo volumio[10080]: spawnargs: [ Jun 02 21:11:31 rivo volumio[10080]: '-p', Jun 02 21:11:31 rivo volumio[10080]: 9876, Jun 02 21:11:31 rivo volumio[10080]: '-o', Jun 02 21:11:31 rivo volumio[10080]: '/tmp/camilladsp.log', Jun 02 21:11:31 rivo volumio[10080]: '-l', Jun 02 21:11:31 rivo volumio[10080]: 'warn', Jun 02 21:11:31 rivo volumio[10080]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 02 21:11:31 rivo volumio[10080]: ] Jun 02 21:11:31 rivo volumio[10080]: } Jun 02 21:11:31 rivo volumio[10080]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:11:31 rivo sudo[10453]: pam_unix(sudo:session): session closed for user root Jun 02 21:11:32 rivo sudo[10465]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-06-02 21:10 Jun 02 21:11:32 rivo sudo[10465]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 11:38:48 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="8e381701610c2a79deb52e712150c089"