May 28 16:51:00 volumio volumio[983]: info: Get:4 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libpython3.11-stdlib armhf 3.11.2-6+deb12u7 [1669 kB] May 28 16:51:00 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:00.140+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:02 volumio volumio[983]: info: Get:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3.11-minimal armhf 3.11.2-6+deb12u7 [1684 kB] May 28 16:51:02 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:02.608+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:04 volumio volumio[983]: info: Get:6 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libpython3.11-minimal armhf 3.11.2-6+deb12u7 [801 kB] May 28 16:51:04 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:04.070+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:04 volumio volumio[983]: info: Get:7 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf drc armhf 3.2.3~dfsg0-1 [118 kB] May 28 16:51:04 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:04.726+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:04 volumio volumio[983]: info: Get:8 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3-setuptools-whl all 66.1.1-1+deb12u2 [1112 kB] May 28 16:51:04 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:04.824+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:06 volumio volumio[983]: info: Get:9 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3.11-venv armhf 3.11.2-6+deb12u7 [5892 B] May 28 16:51:06 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:06.208+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:07 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:07 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:07 volumio volumio[983]: info: Fetched 9347 kB in 8s (1116 kB/s) May 28 16:51:07 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:07.876+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:09 volumio volumio[983]: [620B blob data] May 28 16:51:09 volumio volumio[983]: info: Preparing to unpack .../0-libpython3.11_3.11.2-6+deb12u7_armhf.deb ... May 28 16:51:09 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:09.300+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:09 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:09.344+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:09 volumio volumio[983]: info: Unpacking libpython3.11:armhf (3.11.2-6+deb12u7) over (3.11.2-6+deb12u6) ... May 28 16:51:09 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:09.424+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:12 volumio volumio[983]: info: Preparing to unpack .../1-python3.11_3.11.2-6+deb12u7_armhf.deb ... May 28 16:51:12 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:12.375+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:12 volumio volumio[983]: info: Unpacking python3.11 (3.11.2-6+deb12u7) over (3.11.2-6+deb12u6) ... May 28 16:51:12 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:12.936+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:13 volumio volumio[983]: info: Preparing to unpack .../2-libpython3.11-stdlib_3.11.2-6+deb12u7_armhf.deb ... May 28 16:51:13 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:13.713+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:14 volumio volumio[983]: info: Unpacking libpython3.11-stdlib:armhf (3.11.2-6+deb12u7) over (3.11.2-6+deb12u6) ... May 28 16:51:14 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:14.061+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:14 volumio volumio[983]: info: dpkg: error processing archive /tmp/apt-dpkg-install-4s2YgW/2-libpython3.11-stdlib_3.11.2-6+deb12u7_armhf.deb (--unpack): May 28 16:51:14 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:14.350+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:14 volumio volumio[983]: info: trying to overwrite '/usr/lib/python3.11/EXTERNALLY-MANAGED', which is also in package raspberrypi-sys-mods 20250930~bookworm May 28 16:51:14 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:14.395+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:14 volumio volumio[983]: info: Preparing to unpack .../3-python3.11-minimal_3.11.2-6+deb12u7_armhf.deb ... May 28 16:51:14 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:14.587+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:14 volumio volumio[983]: info: Unpacking python3.11-minimal (3.11.2-6+deb12u7) over (3.11.2-6+deb12u6) ... May 28 16:51:14 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:14.642+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:16 volumio volumio[983]: info: Preparing to unpack .../4-libpython3.11-minimal_3.11.2-6+deb12u7_armhf.deb ... May 28 16:51:16 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:16.765+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:17 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:17 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:17 volumio volumio[983]: info: Listing playlists May 28 16:51:17 volumio volumio[983]: info: Listing playlists May 28 16:51:17 volumio volumio[983]: info: Unpacking libpython3.11-minimal:armhf (3.11.2-6+deb12u7) over (3.11.2-6+deb12u6) ... May 28 16:51:17 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:17.198+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:21 volumio volumio[983]: info: Selecting previously unselected package drc. May 28 16:51:21 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:21.391+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:21 volumio volumio[983]: info: Preparing to unpack .../5-drc_3.2.3~dfsg0-1_armhf.deb ... May 28 16:51:21 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:21.422+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:21 volumio volumio[983]: info: Unpacking drc (3.2.3~dfsg0-1) ... May 28 16:51:21 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:21.450+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:22 volumio volumio[983]: info: Selecting previously unselected package python3-pip-whl. May 28 16:51:22 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:22.044+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:22 volumio volumio[983]: info: Preparing to unpack .../6-python3-pip-whl_23.0.1+dfsg-1+rpt1_all.deb ... May 28 16:51:22 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:22.077+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:22 volumio volumio[983]: info: Unpacking python3-pip-whl (23.0.1+dfsg-1+rpt1) ... May 28 16:51:22 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:22.110+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:22 volumio volumio[983]: info: Selecting previously unselected package python3-setuptools-whl. May 28 16:51:22 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:22.595+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:22 volumio volumio[983]: info: Preparing to unpack .../7-python3-setuptools-whl_66.1.1-1+deb12u2_all.deb ... May 28 16:51:22 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:22.640+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:22 volumio volumio[983]: info: Unpacking python3-setuptools-whl (66.1.1-1+deb12u2) ... May 28 16:51:22 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:22.666+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:22 volumio volumio[983]: info: Selecting previously unselected package python3.11-venv. May 28 16:51:22 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:22.989+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:23 volumio volumio[983]: info: Preparing to unpack .../8-python3.11-venv_3.11.2-6+deb12u7_armhf.deb ... May 28 16:51:23 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:23.024+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:23 volumio volumio[983]: info: Unpacking python3.11-venv (3.11.2-6+deb12u7) ... May 28 16:51:23 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:23.050+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:23 volumio volumio[983]: info: Selecting previously unselected package python3-venv. May 28 16:51:23 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:23.159+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:23 volumio volumio[983]: info: Preparing to unpack .../9-python3-venv_3.11.2-1_armhf.deb ... May 28 16:51:23 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:23.186+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:23 volumio volumio[983]: info: Unpacking python3-venv (3.11.2-1) ... May 28 16:51:23 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:23.214+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:23 volumio volumio[983]: info: Errors were encountered while processing: May 28 16:51:23 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:23.350+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:23 volumio volumio[983]: info: /tmp/apt-dpkg-install-4s2YgW/2-libpython3.11-stdlib_3.11.2-6+deb12u7_armhf.deb May 28 16:51:23 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:23.371+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:28 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:28 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:31 volumio sudo[4785]: pam_unix(sudo:session): session closed for user root May 28 16:51:31 volumio volumio[983]: info: creating sysytemd service May 28 16:51:31 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:31.577+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:31 volumio sudo[5030]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload May 28 16:51:31 volumio sudo[5030]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 28 16:51:31 volumio systemd[1]: Reloading. May 28 16:51:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 28 16:51:33 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 28 16:51:33 volumio sudo[5030]: pam_unix(sudo:session): session closed for user root May 28 16:51:33 volumio volumio[983]: info: copying hw detection script May 28 16:51:33 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:33.748+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:33 volumio volumio[983]: info: Detected cpu architecture as armv7l May 28 16:51:33 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:33.809+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:36 volumio sudo[5076]: root : PWD=/tmp ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params May 28 16:51:36 volumio sudo[5076]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 28 16:51:36 volumio sudo[5076]: pam_unix(sudo:session): session closed for user root May 28 16:51:36 volumio sudo[5078]: root : PWD=/tmp ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params May 28 16:51:36 volumio sudo[5078]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 28 16:51:36 volumio sudo[5078]: pam_unix(sudo:session): session closed for user root May 28 16:51:36 volumio volumio[983]: info: Downloading camillagui ... Please wait! May 28 16:51:36 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:36.131+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:42 volumio volumio[983]: info: Extracting camillagui ... May 28 16:51:42 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:42.932+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:42 volumio volumio[983]: info: camillagui_backend/ May 28 16:51:42 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:42.969+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:42 volumio volumio[983]: info: camillagui_backend/camillagui_backend May 28 16:51:42 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:42.988+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/ May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.150+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/ May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.170+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/ May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.193+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft7/ May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.221+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft7/metaschema.json May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.252+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft3/ May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.275+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft3/metaschema.json May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.303+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/ May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.332+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/metaschema.json May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.362+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/ May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.408+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/core May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/content May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.940+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.940+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/meta-data May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.949+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:43 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/format-assertion May 28 16:51:43 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:43.983+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/validation May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.021+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/applicator May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.043+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/format-annotation May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.075+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft202012/vocabularies/unevaluated May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.106+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft4/ May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.139+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft4/metaschema.json May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.166+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft6/ May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.195+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft6/metaschema.json May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.224+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/ May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.252+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/metaschema.json May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.704+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/vocabularies/ May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.730+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:44 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/vocabularies/core May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.757+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/vocabularies/content May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.784+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:44 volumio volumio[983]: info: Listing playlists May 28 16:51:44 volumio volumio[983]: info: Listing playlists May 28 16:51:44 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/vocabularies/meta-data May 28 16:51:44 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:44.809+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:45 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/vocabularies/validation May 28 16:51:45 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:45.445+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:45 volumio sudo[4608]: pam_unix(sudo:session): session closed for user root May 28 16:51:45 volumio volumio[983]: info: Install script completed May 28 16:51:45 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:45.697+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:45 volumio volumio[983]: info: Adding reference to registry May 28 16:51:45 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:45.890+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:45 volumio volumio[983]: info: Done installing plugin. May 28 16:51:45 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 16:51:45 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 28 16:51:45 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/vocabularies/applicator May 28 16:51:45 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:45.945+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:45 volumio volumio[983]: info: Folder /tmp/plugins removed May 28 16:51:45 volumio volumio[983]: info: Folder /tmp/downloaded_plugin.zip removed May 28 16:51:45 volumio volumio[983]: info: Folder /data/temp removed May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema_specifications/schemas/draft201909/vocabularies/format May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.006+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/libpython3.11.so.1.0 May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.033+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/ May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.066+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/fft/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/fft/_pocketfft_umath.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/_core/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/_core/_multiarray_tests.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/_core/_multiarray_umath.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.097+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.100+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.103+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.108+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.109+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/ May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.242+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/bit_generator.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/_common.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/_mt19937.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/mtrand.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/_philox.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/_generator.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/_sfc64.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/_bounded_integers.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/random/_pcg64.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/linalg/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/numpy/linalg/_umath_linalg.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/libstdc++.so.6 May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/yarl/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/yarl/_quoting_c.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/rpds/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/rpds/rpds.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/libssl.so.3 May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/resampler.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/basicfilters.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/dither.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/filter.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/compressor.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/race.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/pipeline.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/signalgen.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/sections.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/processor.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/mixer.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/playback.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/biquads.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/biquadcombo.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/diffeq.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/conv.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/capture.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/noisegate.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/camilladsp_plot/schemas/devices.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/libbz2.so.1.0 May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/libexpat.so.1 May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/css-variables.css May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/logo512.png May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/manifest.json May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/robots.txt May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/assets/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/assets/index-BcskH8eu.js May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/assets/camilladsp-BEmSmbVE.svg May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/assets/index-Baoof0XQ.css May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/index.html May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/logo192.png May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/build/favicon.ico May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/libz.so.1 May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/libcrypto.so.3 May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/base_library.zip May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.409+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.410+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.412+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.413+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.415+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.417+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.418+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.419+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.421+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.422+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.425+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.426+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.430+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.433+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.434+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.437+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.438+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.440+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.441+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.443+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.445+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.449+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.451+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.456+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.457+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.459+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.460+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.473+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.483+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.486+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.488+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.492+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.493+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.494+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.496+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.502+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.506+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.507+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.510+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.511+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.513+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.515+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.517+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.517+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.525+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.525+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.526+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.536+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.537+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.542+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.547+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.550+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.552+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.553+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.554+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/ May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.919+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/ May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_bz2.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_multibytecodec.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_codecs_hk.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_asyncio.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_codecs_kr.cpython-311-arm-linux-gnueabihf.so May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.934+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.935+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.937+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.941+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.944+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:46 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:46.947+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/resource.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_codecs_iso2022.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.068+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_ssl.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_codecs_tw.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_codecs_cn.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/mmap.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_multiprocessing.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_codecs_jp.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.094+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.096+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.099+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.103+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.104+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.107+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.109+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_json.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.183+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_typing.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_hashlib.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_contextvars.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_decimal.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_queue.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_posixshmem.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_uuid.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_ctypes.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/termios.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/_lzma.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/python3.11/lib-dynload/readline.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/METADATA May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/entry_points.txt May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/INSTALLER May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/fft/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/fft/pocketfft/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/fft/pocketfft/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/include/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/include/numpy/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/include/numpy/libdivide/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/include/numpy/libdivide/LICENSE.txt May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/npysort/ May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.262+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.263+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.272+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.273+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.275+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.276+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.279+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.288+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.290+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.294+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.295+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.298+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.299+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.305+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.308+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.312+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.318+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.319+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.332+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.334+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.337+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.344+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.345+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.347+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.348+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.361+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.362+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:47 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/npysort/x86-simd-sort/ May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.543+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/npysort/x86-simd-sort/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/highway/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/highway/LICENSE May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/multiarray/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/multiarray/dragon4_LICENSE.txt May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/umath/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/umath/svml/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/umath/svml/LICENSE May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/common/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/common/pythoncapi-compat/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/_core/src/common/pythoncapi-compat/COPYING May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/ma/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/ma/LICENSE May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/distributions/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/distributions/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/mt19937/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/mt19937/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/philox/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/philox/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/pcg64/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/pcg64/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/sfc64/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/sfc64/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/splitmix64/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/random/src/splitmix64/LICENSE.md May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/linalg/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/linalg/lapack_lite/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/numpy/linalg/lapack_lite/LICENSE.txt May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/licenses/LICENSE.txt May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/WHEEL May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/numpy-2.4.4.dist-info/RECORD May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema/benchmarks/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema/benchmarks/issue232/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema/benchmarks/issue232/issue.json May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/libffi.so.8 May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/frozenlist/ May 28 16:51:47 volumio volumio[983]: info: camillagui_backend/_internal/frozenlist/_frozenlist.cpython-311-arm-linux-gnueabihf.so May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.657+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.661+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.663+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.665+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.672+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.678+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.681+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.682+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.684+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.687+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.688+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.691+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.695+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.696+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.696+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.699+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.701+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.703+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.705+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.707+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.710+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.714+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.716+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.718+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.721+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.726+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.727+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.729+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.731+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.733+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.735+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.738+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.740+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.742+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.746+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.751+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.752+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.756+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.758+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.760+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:47 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:47.761+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/aiohttp/ May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.370+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/aiohttp/_websocket/ May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/aiohttp/_websocket/reader_c.cpython-311-arm-linux-gnueabihf.so May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.385+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.387+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/aiohttp/_websocket/mask.cpython-311-arm-linux-gnueabihf.so May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/aiohttp/_http_parser.cpython-311-arm-linux-gnueabihf.so May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.424+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.430+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/aiohttp/_http_writer.cpython-311-arm-linux-gnueabihf.so May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.452+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/libgcc_s.so.1 May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/ May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.471+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/REQUESTED May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/METADATA May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/entry_points.txt May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/INSTALLER May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/licenses/ May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/licenses/COPYING May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/WHEEL May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/jsonschema-4.26.0.dist-info/RECORD May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/libreadline.so.8 May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/multidict/ May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/multidict/_multidict.cpython-311-arm-linux-gnueabihf.so May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/liblzma.so.5 May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/config/ May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/config/gui-config.yml May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/config/camillagui.yml May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/libuuid.so.1 May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/attrs-26.1.0.dist-info/ May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/attrs-26.1.0.dist-info/METADATA May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/attrs-26.1.0.dist-info/INSTALLER May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/attrs-26.1.0.dist-info/licenses/ May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/attrs-26.1.0.dist-info/licenses/LICENSE May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/attrs-26.1.0.dist-info/WHEEL May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/attrs-26.1.0.dist-info/RECORD May 28 16:51:48 volumio volumio[983]: info: camillagui_backend/_internal/libtinfo.so.6 May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.547+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.549+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.577+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.578+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.589+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.596+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.597+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.598+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.609+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.614+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.624+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.625+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.627+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.628+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.631+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.633+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.639+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.640+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.643+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.645+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.650+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.663+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.667+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.670+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:48.674+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:48 volumio volumio[983]: Plugin install end detected on script May 28 16:51:50 volumio ntpd[749]: PROTO: 185.134.42.7 unlink local addr 192.168.1.224 -> May 28 16:51:52 volumio volumio[983]: info: Enabling plugin fusiondsp May 28 16:51:52 volumio volumio[983]: info: Loading plugin "fusiondsp"... May 28 16:51:53 volumio volumio[983]: info: Preparing to generate the ALSA configuration file May 28 16:51:53 volumio volumio[983]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 28 16:51:53 volumio volumio[983]: info: Reading ALSA contributions from plugins. May 28 16:51:53 volumio volumio[983]: info: Asound.conf file written May 28 16:51:53 volumio sudo[5108]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 28 16:51:53 volumio sudo[5108]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:53 volumio sudo[5108]: pam_unix(sudo:session): session closed for user root May 28 16:51:53 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 28 16:51:53 volumio volumio[983]: No state is present for card b1 May 28 16:51:53 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 28 16:51:53 volumio volumio[983]: /usr/share/alsa/init/bcm2835:14: control element not found May 28 16:51:53 volumio volumio[983]: No state is present for card b1 May 28 16:51:53 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 28 16:51:53 volumio volumio[983]: No state is present for card Headphones May 28 16:51:53 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 28 16:51:53 volumio volumio[983]: /usr/share/alsa/init/bcm2835:20: control element not found May 28 16:51:53 volumio volumio[983]: No state is present for card Headphones May 28 16:51:53 volumio volumio[983]: No state is present for card Audio May 28 16:51:53 volumio volumio[983]: Found hardware: "USB-Audio" "USB Mixer" "USB262a:1a1c" "" "" May 28 16:51:53 volumio volumio[983]: Hardware is initialized using a generic method May 28 16:51:53 volumio volumio[983]: No state is present for card Audio May 28 16:51:53 volumio volumio[983]: info: Output device has changed, restarting MPD May 28 16:51:53 volumio volumio[983]: info: Output device has changed, restarting Shairport Sync May 28 16:51:53 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:53 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 16:51:53 volumio sudo[5114]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 28 16:51:53 volumio sudo[5114]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:53 volumio sudo[5114]: pam_unix(sudo:session): session closed for user root May 28 16:51:53 volumio sudo[5116]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 28 16:51:53 volumio sudo[5116]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:53 volumio volumio[983]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 16:51:53 volumio volumio[983]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 28 16:51:53 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:53 volumio volumio[983]: info: QobuzConnect: setDeactiveState invoked May 28 16:51:53 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:53 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:53 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... May 28 16:51:53 volumio volumio[983]: info: PLUGIN START: fusiondsp May 28 16:51:53 volumio sudo[5126]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 16:51:53 volumio sudo[5126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:53 volumio volumio[983]: info: FusionDsp - CamillaDSP binary found. May 28 16:51:53 volumio volumio[983]: info: Loading i18n strings for locale es May 28 16:51:53 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 28 16:51:53 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:53 volumio volumio[983]: info: FusionDsp - mixtype--------------------- Hardware May 28 16:51:53 volumio volumio[983]: info: Preparing to generate the ALSA configuration file May 28 16:51:53 volumio volumio[983]: info: Done. May 28 16:51:53 volumio sudo[5126]: pam_unix(sudo:session): session closed for user root May 28 16:51:53 volumio sudo[5130]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 16:51:53 volumio sudo[5130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:53 volumio volumio[983]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 28 16:51:53 volumio volumio[983]: info: Reading ALSA contributions from plugins. May 28 16:51:53 volumio volumio[983]: info: MPD Permissions set May 28 16:51:53 volumio sudo[5137]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 28 16:51:53 volumio volumio[983]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 May 28 16:51:53 volumio sudo[5137]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio sudo[5130]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio sudo[5137]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio sudo[5147]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 28 16:51:54 volumio sudo[5147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... May 28 16:51:54 volumio volumio[983]: info: Starting Shairport Sync May 28 16:51:54 volumio volumio[983]: info: Asound.conf file unchanged, so no further update is needed May 28 16:51:54 volumio volumio[983]: info: Output device has changed, restarting MPD May 28 16:51:54 volumio sudo[5150]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 16:51:54 volumio sudo[5150]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio volumio[983]: info: Output device has changed, restarting Shairport Sync May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 16:51:54 volumio sudo[5153]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 28 16:51:54 volumio sudo[5153]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio sudo[5153]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio sudo[5155]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 28 16:51:54 volumio sudo[5155]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 28 16:51:54 volumio volumio[983]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 16:51:54 volumio volumio[983]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: QobuzConnect: setDeactiveState invoked May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:54 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:54 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 28 16:51:54 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 28 16:51:54 volumio systemd[1]: shairport-sync.service: Consumed 4.396s CPU time. May 28 16:51:54 volumio sudo[5165]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 16:51:54 volumio sudo[5169]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 16:51:54 volumio sudo[5169]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio sudo[5165]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 28 16:51:54 volumio sudo[5150]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio volumio[983]: info: MPD Permissions set May 28 16:51:54 volumio volumio[983]: info: Shairport-Sync Started May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio sudo[5174]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 28 16:51:54 volumio sudo[5174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 16:51:54 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:54 volumio volumio[983]: info: Starting Shairport Sync May 28 16:51:54 volumio sudo[5184]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 16:51:54 volumio sudo[5184]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio sudo[5174]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 28 16:51:54 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 28 16:51:54 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 28 16:51:54 volumio sudo[5186]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 28 16:51:54 volumio sudo[5186]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:54 volumio qobuz-connect[3355]: 20260528 16:51:54.768 [3355.3355] INFO SampleApp: Stopping Local configuration server May 28 16:51:54 volumio sudo[5169]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio sudo[5165]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 28 16:51:54 volumio sudo[5184]: pam_unix(sudo:session): session closed for user root May 28 16:51:54 volumio volumio[983]: info: Shairport-Sync Started May 28 16:51:55 volumio qobuz-connect[3355]: 20260528 16:51:55.645 [3355.3355] INFO SampleApp: shat down connection on UNIX socket May 28 16:51:55 volumio volumio[983]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 28 16:51:55 volumio volumio[983]: info: QobuzConnect: setDeactiveState invoked May 28 16:51:55 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:55 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:55 volumio volumio[983]: info: Starting Uninstall of plugin audio_interface - fusiondsp May 28 16:51:55 volumio volumio[983]: info: Uninstalling plugin fusiondsp May 28 16:51:55 volumio volumio[983]: info: FusionDsp - Stopping clipped samples monitor May 28 16:51:55 volumio volumio[983]: info: FusionDsp - Clipped samples monitor stopped May 28 16:51:55 volumio volumio[983]: info: FusionDsp - Stopping FusionDsp service May 28 16:51:55 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:55.749+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:55 volumio volumio[983]: info: Disabling plugin fusiondsp May 28 16:51:55 volumio volumio[983]: info: Preparing to generate the ALSA configuration file May 28 16:51:55 volumio sudo[5221]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service May 28 16:51:55 volumio sudo[5221]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:55 volumio volumio[983]: info: CoreCommandRouter::volumioPause May 28 16:51:55 volumio volumio[983]: info: CoreStateMachine::pause May 28 16:51:55 volumio volumio[983]: info: Asound.conf file written May 28 16:51:55 volumio sudo[5225]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 28 16:51:55 volumio sudo[5225]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:55 volumio sudo[5225]: pam_unix(sudo:session): session closed for user root May 28 16:51:55 volumio sudo[5221]: pam_unix(sudo:session): session closed for user root May 28 16:51:55 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 28 16:51:55 volumio volumio[983]: No state is present for card b1 May 28 16:51:55 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 May 28 16:51:55 volumio volumio[983]: /usr/share/alsa/init/bcm2835:14: control element not found May 28 16:51:55 volumio volumio[983]: No state is present for card b1 May 28 16:51:55 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 28 16:51:55 volumio volumio[983]: No state is present for card Headphones May 28 16:51:55 volumio volumio[983]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 May 28 16:51:55 volumio volumio[983]: /usr/share/alsa/init/bcm2835:20: control element not found May 28 16:51:55 volumio volumio[983]: No state is present for card Headphones May 28 16:51:55 volumio volumio[983]: No state is present for card Audio May 28 16:51:55 volumio volumio[983]: Found hardware: "USB-Audio" "USB Mixer" "USB262a:1a1c" "" "" May 28 16:51:55 volumio volumio[983]: Hardware is initialized using a generic method May 28 16:51:55 volumio volumio[983]: No state is present for card Audio May 28 16:51:55 volumio volumio[983]: info: Output device has changed, restarting MPD May 28 16:51:56 volumio sudo[5232]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 28 16:51:56 volumio sudo[5232]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio volumio[983]: info: Output device has changed, restarting Shairport Sync May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 16:51:56 volumio sudo[5232]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio sudo[5234]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 28 16:51:56 volumio sudo[5234]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio volumio[983]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 28 16:51:56 volumio volumio[983]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: QobuzConnect: setDeactiveState invoked May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:56 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:56 volumio volumio[983]: info: Checking if uninstall.sh is present May 28 16:51:56 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:56.151+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:56 volumio sudo[5244]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 16:51:56 volumio sudo[5244]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio sudo[5246]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 28 16:51:56 volumio sudo[5246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio volumio[983]: info: Executing uninstall.sh May 28 16:51:56 volumio sudo[5254]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service May 28 16:51:56 volumio sudo[5254]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio volumio[983]: info: MPD Permissions set May 28 16:51:56 volumio volumio[983]: info: FusionDsp - Reporting Fusion DSP Disabled May 28 16:51:56 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. May 28 16:51:56 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 28 16:51:56 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:51:56 volumio sudo[5258]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh May 28 16:51:56 volumio sudo[5258]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio sudo[5244]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio volumio[983]: info: Starting Shairport Sync May 28 16:51:56 volumio sudo[5254]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio sudo[5268]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 28 16:51:56 volumio sudo[5271]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service May 28 16:51:56 volumio sudo[5268]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio sudo[5271]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:56 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. May 28 16:51:56 volumio sudo[5186]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio sudo[5147]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio sudo[5246]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... May 28 16:51:56 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... May 28 16:51:56 volumio systemd[1]: shairport-sync.service: Deactivated successfully. May 28 16:51:56 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 28 16:51:56 volumio systemd[1]: shairport-sync.service: Consumed 1.439s CPU time. May 28 16:51:56 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. May 28 16:51:56 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. May 28 16:51:56 volumio volumio[983]: info: TidalConnect service stoped! May 28 16:51:56 volumio sudo[5275]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/rm /etc/systemd/system/fusiondsp.service May 28 16:51:56 volumio sudo[5275]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 28 16:51:56 volumio sudo[5275]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio sudo[5278]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload May 28 16:51:56 volumio sudo[5278]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 28 16:51:56 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. May 28 16:51:56 volumio sudo[5271]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. May 28 16:51:56 volumio sudo[5268]: pam_unix(sudo:session): session closed for user root May 28 16:51:56 volumio volumio[983]: info: Shairport-Sync Started May 28 16:51:57 volumio systemd[1]: Reloading. May 28 16:51:57 volumio volumio[983]: (node:983) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 28 16:51:57 volumio volumio[983]: (Use `node --trace-warnings ...` to show where the warning was created) May 28 16:51:57 volumio volumio[983]: (node:983) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 28 16:51:57 volumio volumio[983]: (node:983) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 28 16:51:57 volumio volumio[983]: (node:983) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 28 16:51:57 volumio volumio[983]: (node:983) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 28 16:51:57 volumio volumio[983]: info: TidalConnect service stoped! May 28 16:51:57 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:57 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:57 volumio volumio[983]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 28 16:51:57 volumio volumio[983]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 28 16:51:57 volumio volumio[983]: info: Executing endpoint qc_getconfig May 28 16:51:57 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 28 16:51:57 volumio sudo[5317]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 28 16:51:57 volumio sudo[5317]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.528 [5277.5277] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 28 16:51:57 volumio volumio[983]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 28 16:51:57 volumio volumio[983]: info: QobuzConnect: QOBUZ Connect daemon connected May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.568 [5277.5277] INFO VolumeManager: [0xeff058]: Setting new playback volume: 75 May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.569 [5277.5277] INFO VolumeManager: [0xeff058]: Setting new mute state: 0 May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.569 [5277.5277] INFO AudioStreamManager: [0xefedb0]: Setting new audio download buffer size: 1048576 May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.569 [5277.5277] INFO QobuzConnect: [0xeff920]: Client initialized! May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.569 [5277.5277] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.596 [5277.5277] INFO LocalConfigManager: [0xefead8]: Starting Local Configuration server May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.597 [5277.5277] INFO SampleApp: Starting Local configuration server May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.597 [5277.5277] INFO SampleApp: Connected to UNIX socket client 0xee9818 May 28 16:51:57 volumio qobuz-connect[5277]: 20260528 16:51:57.678 [5277.5277] INFO SampleApp: Playback volume changed: 75 May 28 16:51:57 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:51:57 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:51:57 volumio volumio[983]: info: TidalConnect service stoped! May 28 16:51:57 volumio volumio[983]: info: TidalConnect service stoped! May 28 16:51:57 volumio volumio[983]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 28 16:51:57 volumio volumio[983]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 28 16:51:57 volumio sudo[5339]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 28 16:51:57 volumio sudo[5339]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:51:58 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 28 16:51:58 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. May 28 16:51:59 volumio sudo[5278]: pam_unix(sudo:session): session closed for user root May 28 16:51:59 volumio sudo[5258]: pam_unix(sudo:session): session closed for user root May 28 16:51:59 volumio volumio[983]: info: Uninstall script completed May 28 16:51:59 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:59.070+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:59 volumio volumio[983]: info: Removing plugin fusiondsp from configuration May 28 16:51:59 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. May 28 16:51:59 volumio sudo[5339]: pam_unix(sudo:session): session closed for user root May 28 16:51:59 volumio sudo[5317]: pam_unix(sudo:session): session closed for user root May 28 16:51:59 volumio volumio[983]: info: Successfully removed fusiondsp configuration files May 28 16:51:59 volumio volumio[983]: info: Plugin folders cleanup May 28 16:51:59 volumio volumio[983]: info: Scanning into folder /volumio/app/plugins/ May 28 16:51:59 volumio volumio5-onboarding[1310]: time=2026-05-28T16:51:59.902+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:51:59 volumio volumio[983]: info: Scanning category audio_interface May 28 16:51:59 volumio volumio[983]: info: Scanning category miscellanea May 28 16:51:59 volumio volumio[983]: info: Scanning category music_service May 28 16:51:59 volumio volumio[983]: info: Scanning category plugins.json May 28 16:51:59 volumio volumio[983]: info: Scanning category system_controller May 28 16:51:59 volumio volumio[983]: info: Scanning category user_interface May 28 16:51:59 volumio volumio[983]: info: Scanning into folder /data/plugins/ May 28 16:51:59 volumio volumio[983]: info: Scanning category audio_interface May 28 16:51:59 volumio volumio[983]: info: Cleaning folder for fusiondsp May 28 16:52:00 volumio volumio[983]: info: Plugin folders cleanup completed May 28 16:52:00 volumio volumio5-onboarding[1310]: time=2026-05-28T16:52:00.978+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state May 28 16:52:00 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 28 16:52:00 volumio volumio[983]: info: [] May 28 16:52:00 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 28 16:52:01 volumio volumio[983]: info: TidalConnect service stoped! May 28 16:52:01 volumio volumio[983]: info: TidalConnect service stoped! May 28 16:52:01 volumio volumio[983]: info: Executing endpoint tc_getconfig May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 28 16:52:01 volumio vtcs[5348]: STARTING TidalConnect services, version: 1.6.1 May 28 16:52:01 volumio vtcs[5348]: [2026-05-28 16:52:01.048] [tisoc] [critical] [DeviceInfo.cpp:52] ioctl error. ret=-1, errno="No such device" May 28 16:52:01 volumio vtcs[5348]: [2026-05-28 16:52:01.048] [tisoc] [critical] [DeviceInfo.cpp:53] [ASSERT] generateDeviceId(0) May 28 16:52:01 volumio vtcs[5348]: STARTED TidalConnect services. May 28 16:52:01 volumio volumio[983]: info: Executing endpoint tc_connect May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 28 16:52:01 volumio volumio[983]: info: Connecting to TidalConnect May 28 16:52:01 volumio volumio[983]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 28 16:52:01 volumio volumio[983]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::servicePushState May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::pushState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioPushState May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output update for this device May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 28 16:52:01 volumio volumio[983]: verbose: CURRENT POSITION 0 May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::syncState stateService stop May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::syncState currentStatus stop May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::pushState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioPushState May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output update for this device May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: No code May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::pushState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioPushState May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output update for this device May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::servicePushState May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::pushState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioPushState May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output update for this device May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} May 28 16:52:01 volumio volumio[983]: verbose: CURRENT POSITION 0 May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::syncState stateService stop May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::syncState currentStatus stop May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::pushState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioPushState May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output update for this device May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: No code May 28 16:52:01 volumio volumio[983]: info: CoreStateMachine::pushState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioPushState May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output update for this device May 28 16:52:01 volumio volumio[983]: info: MRS: Pushing multiroomSync output May 28 16:52:01 volumio volumio[983]: info: CoreCommandRouter::volumioGetState May 28 16:52:01 volumio volumio[983]: info: CorePlayQueue::getTrack 0 May 28 16:52:01 volumio sudo[5373]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 28 16:52:01 volumio sudo[5373]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:52:01 volumio sudo[5373]: pam_unix(sudo:session): session closed for user root May 28 16:52:01 volumio systemd[1]: mpd.service: Deactivated successfully. May 28 16:52:01 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. May 28 16:52:01 volumio systemd[1]: mpd.service: Consumed 6.798s CPU time. May 28 16:52:01 volumio systemd[1]: mpd.socket: Deactivated successfully. May 28 16:52:01 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. May 28 16:52:01 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... May 28 16:52:02 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. May 28 16:52:02 volumio systemd[1]: Starting mpd.service - Music Player Daemon... May 28 16:52:02 volumio volumio[983]: info: TidalConnect service started! May 28 16:52:02 volumio volumio[983]: info: TidalConnect service started! May 28 16:52:02 volumio sudo[5378]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 28 16:52:02 volumio sudo[5378]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) May 28 16:52:02 volumio sudo[5378]: pam_unix(sudo:session): session closed for user root May 28 16:52:02 volumio volumio[983]: info: FusionDsp - If filter freq >samplerate/2 then disable it May 28 16:52:02 volumio volumio[983]: error: ENOENT: no such file or directory, open '/data/plugins/audio_interface/fusiondsp/camilladsp.conf.yml' {"code":"ENOENT","errno":-2,"path":"/data/plugins/audio_interface/fusiondsp/camilladsp.conf.yml","syscall":"open"} May 28 16:52:02 volumio volumio[983]: info: camilladsp service started and running in background, instance 1 May 28 16:52:02 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 28 16:52:03 volumio volumio[983]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent May 28 16:52:03 volumio volumio[983]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 28 16:52:03 volumio volumio[983]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent May 28 16:52:03 volumio volumio[983]: info: FusionDsp loaded May 28 16:52:03 volumio volumio[983]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 28 16:52:03 volumio volumio[983]: info: FusionDsp - --[object Object] May 28 16:52:03 volumio volumio[983]: info: FusionDsp - Reporting Fusion DSP Enabled May 28 16:52:03 volumio volumio[983]: info: Adding Signal Path Element [object Object] May 28 16:52:03 volumio volumio[983]: info: Adding fusiondspeq DSP Signal Path Element May 28 16:52:03 volumio volumio[983]: info: FusionDsp - ---- installed callbackRead (debounced 200ms) May 28 16:52:03 volumio sudo[5392]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 28 16:52:03 volumio sudo[5392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) May 28 16:52:03 volumio volumio[983]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 16:52:03 volumio volumio[983]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT May 28 16:52:03 volumio volumio[983]: at ChildProcess._handle.onexit (node:internal/child_process:286:19) May 28 16:52:03 volumio volumio[983]: at onErrorNT (node:internal/child_process:484:16) May 28 16:52:03 volumio volumio[983]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) { May 28 16:52:03 volumio volumio[983]: errno: -2, May 28 16:52:03 volumio volumio[983]: code: 'ENOENT', May 28 16:52:03 volumio volumio[983]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 28 16:52:03 volumio volumio[983]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 28 16:52:03 volumio volumio[983]: spawnargs: [ May 28 16:52:03 volumio volumio[983]: '-p', May 28 16:52:03 volumio volumio[983]: 9876, May 28 16:52:03 volumio volumio[983]: '-o', May 28 16:52:03 volumio volumio[983]: '/tmp/camilladsp.log', May 28 16:52:03 volumio volumio[983]: '-l', May 28 16:52:03 volumio volumio[983]: 'warn', May 28 16:52:03 volumio volumio[983]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 28 16:52:03 volumio volumio[983]: ] May 28 16:52:03 volumio volumio[983]: } May 28 16:52:03 volumio volumio[983]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 28 16:52:03 volumio sudo[5392]: pam_unix(sudo:session): session closed for user root May 28 16:52:06 volumio sudo[5422]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-28 16:51' May 28 16:52:06 volumio sudo[5422]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"