Aug 28 15:20:00 volumio volumio[1315]: info: Unpacking libpython3.11:amd64 (3.11.2-6+deb12u8) over (3.11.2-6+deb12u6) ... Aug 28 15:20:00 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:00.019+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:00 volumio volumio[1315]: info: Preparing to unpack .../01-python3.11_3.11.2-6+deb12u8_amd64.deb ... Aug 28 15:20:00 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:00.434+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:00 volumio volumio[1315]: info: Unpacking python3.11 (3.11.2-6+deb12u8) over (3.11.2-6+deb12u6) ... Aug 28 15:20:00 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:00.662+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:00 volumio volumio[1315]: info: Preparing to unpack .../02-libpython3.11-stdlib_3.11.2-6+deb12u8_amd64.deb ... Aug 28 15:20:00 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:00.783+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:00 volumio volumio[1315]: info: Unpacking libpython3.11-stdlib:amd64 (3.11.2-6+deb12u8) over (3.11.2-6+deb12u6) ... Aug 28 15:20:00 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:00.925+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:02 volumio volumio[1315]: info: Preparing to unpack .../03-python3.11-minimal_3.11.2-6+deb12u8_amd64.deb ... Aug 28 15:20:02 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:02.645+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:02 volumio volumio[1315]: info: Unpacking python3.11-minimal (3.11.2-6+deb12u8) over (3.11.2-6+deb12u6) ... Aug 28 15:20:02 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:02.685+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:03 volumio volumio[1315]: info: Preparing to unpack .../04-libpython3.11-minimal_3.11.2-6+deb12u8_amd64.deb ... Aug 28 15:20:03 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:03.098+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:03 volumio volumio[1315]: info: Unpacking libpython3.11-minimal:amd64 (3.11.2-6+deb12u8) over (3.11.2-6+deb12u6) ... Aug 28 15:20:03 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:03.302+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:04 volumio volumio[1315]: info: Preparing to unpack .../05-libc-l10n_2.36-9+deb12u14_all.deb ... Aug 28 15:20:04 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:04.720+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:04 volumio volumio[1315]: info: Unpacking libc-l10n (2.36-9+deb12u14) over (2.36-9+deb12u13) ... Aug 28 15:20:04 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:04.740+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:04 volumio volumio[1315]: info: Preparing to unpack .../06-locales_2.36-9+deb12u14_all.deb ... Aug 28 15:20:04 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:04.905+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:04 volumio volumio[1315]: info: Unpacking locales (2.36-9+deb12u14) over (2.36-9+deb12u13) ... Aug 28 15:20:04 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:04.924+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:07 volumio volumio[1315]: info: Selecting previously unselected package manpages. Aug 28 15:20:07 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:07.794+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:07 volumio volumio[1315]: info: Preparing to unpack .../07-manpages_6.03-2_all.deb ... Aug 28 15:20:07 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:07.805+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:07 volumio volumio[1315]: info: Unpacking manpages (6.03-2) ... Aug 28 15:20:07 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:07.822+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:08 volumio volumio[1315]: info: Selecting previously unselected package fonts-freefont-ttf. Aug 28 15:20:08 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:08.491+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:08 volumio volumio[1315]: info: Preparing to unpack .../08-fonts-freefont-ttf_20120503-10_all.deb ... Aug 28 15:20:08 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:08.507+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:08 volumio volumio[1315]: info: Unpacking fonts-freefont-ttf (20120503-10) ... Aug 28 15:20:08 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:08.518+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:08 volumio volumio[1315]: info: Selecting previously unselected package libabsl20220623:amd64. Aug 28 15:20:08 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:08.894+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:08 volumio volumio[1315]: info: Preparing to unpack .../09-libabsl20220623_20220623.1-1+deb12u2_amd64.deb ... Aug 28 15:20:08 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:08.918+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:08 volumio volumio[1315]: info: Unpacking libabsl20220623:amd64 (20220623.1-1+deb12u2) ... Aug 28 15:20:08 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:08.933+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Selecting previously unselected package libgav1-1:amd64. Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.241+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Preparing to unpack .../10-libgav1-1_0.18.0-1+b1_amd64.deb ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.266+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Unpacking libgav1-1:amd64 (0.18.0-1+b1) ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.278+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Selecting previously unselected package libyuv0:amd64. Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.445+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Preparing to unpack .../11-libyuv0_0.0~git20230123.b2528b0-1_amd64.deb ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.460+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Unpacking libyuv0:amd64 (0.0~git20230123.b2528b0-1) ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.475+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Selecting previously unselected package libavif15:amd64. Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.560+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Preparing to unpack .../12-libavif15_0.11.1-1+deb12u1_amd64.deb ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.580+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Unpacking libavif15:amd64 (0.11.1-1+deb12u1) ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.594+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Selecting previously unselected package libc-dev-bin. Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.671+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Preparing to unpack .../13-libc-dev-bin_2.36-9+deb12u14_amd64.deb ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.690+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Unpacking libc-dev-bin (2.36-9+deb12u14) ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.715+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Selecting previously unselected package libgd3:amd64. Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.797+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Preparing to unpack .../14-libgd3_2.3.3-9_amd64.deb ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.814+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Unpacking libgd3:amd64 (2.3.3-9) ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.827+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Selecting previously unselected package libc-devtools. Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.905+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Preparing to unpack .../15-libc-devtools_2.36-9+deb12u14_amd64.deb ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.927+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:09 volumio volumio[1315]: info: Unpacking libc-devtools (2.36-9+deb12u14) ... Aug 28 15:20:09 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:09.940+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:10 volumio volumio[1315]: info: Selecting previously unselected package linux-libc-dev:amd64. Aug 28 15:20:10 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:10.024+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:10 volumio volumio[1315]: info: Preparing to unpack .../16-linux-libc-dev_6.1.176-1_amd64.deb ... Aug 28 15:20:10 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:10.039+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:10 volumio volumio[1315]: info: Unpacking linux-libc-dev:amd64 (6.1.176-1) ... Aug 28 15:20:10 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:10.044+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Selecting previously unselected package libcrypt-dev:amd64. Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.108+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Preparing to unpack .../17-libcrypt-dev_1%3a4.4.33-2_amd64.deb ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.133+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Unpacking libcrypt-dev:amd64 (1:4.4.33-2) ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.153+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Selecting previously unselected package libtirpc-dev:amd64. Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.252+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Preparing to unpack .../18-libtirpc-dev_1.3.3+ds-1_amd64.deb ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.273+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Unpacking libtirpc-dev:amd64 (1.3.3+ds-1) ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.280+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Selecting previously unselected package libnsl-dev:amd64. Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.505+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Preparing to unpack .../19-libnsl-dev_1.3.0-2_amd64.deb ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.514+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Unpacking libnsl-dev:amd64 (1.3.0-2) ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.520+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Selecting previously unselected package rpcsvc-proto. Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.621+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Preparing to unpack .../20-rpcsvc-proto_1.4.3-1_amd64.deb ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.641+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Unpacking rpcsvc-proto (1.4.3-1) ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.650+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Selecting previously unselected package libc6-dev:amd64. Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.767+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Preparing to unpack .../21-libc6-dev_2.36-9+deb12u14_amd64.deb ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.791+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:14 volumio volumio[1315]: info: Unpacking libc6-dev:amd64 (2.36-9+deb12u14) ... Aug 28 15:20:14 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:14.815+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Selecting previously unselected package libexpat1-dev:amd64. Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.112+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Preparing to unpack .../22-libexpat1-dev_2.5.0-1+deb12u2_amd64.deb ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.130+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Unpacking libexpat1-dev:amd64 (2.5.0-1+deb12u2) ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.142+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Selecting previously unselected package libfftw3-double3:amd64. Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.264+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Preparing to unpack .../23-libfftw3-double3_3.3.10-1_amd64.deb ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.281+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Unpacking libfftw3-double3:amd64 (3.3.10-1) ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.298+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Selecting previously unselected package libfftw3-long3:amd64. Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.488+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Preparing to unpack .../24-libfftw3-long3_3.3.10-1_amd64.deb ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.499+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Unpacking libfftw3-long3:amd64 (3.3.10-1) ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.507+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Selecting previously unselected package libfftw3-quad3:amd64. Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.626+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Preparing to unpack .../25-libfftw3-quad3_3.3.10-1_amd64.deb ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.644+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Unpacking libfftw3-quad3:amd64 (3.3.10-1) ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.652+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Selecting previously unselected package libfftw3-bin. Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.839+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Preparing to unpack .../26-libfftw3-bin_3.3.10-1_amd64.deb ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.851+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Unpacking libfftw3-bin (3.3.10-1) ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.864+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Selecting previously unselected package libfftw3-dev:amd64. Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.959+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Preparing to unpack .../27-libfftw3-dev_3.3.10-1_amd64.deb ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.969+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:16 volumio volumio[1315]: info: Unpacking libfftw3-dev:amd64 (3.3.10-1) ... Aug 28 15:20:16 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:16.988+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Selecting previously unselected package libjpeg62-turbo-dev:amd64. Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.424+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Preparing to unpack .../28-libjpeg62-turbo-dev_1%3a2.1.5-2_amd64.deb ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.437+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Unpacking libjpeg62-turbo-dev:amd64 (1:2.1.5-2) ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.445+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Selecting previously unselected package libjpeg-dev:amd64. Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.558+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Preparing to unpack .../29-libjpeg-dev_1%3a2.1.5-2_amd64.deb ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.568+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Unpacking libjpeg-dev:amd64 (1:2.1.5-2) ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.578+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Selecting previously unselected package libopusfile0:amd64. Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.646+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Preparing to unpack .../30-libopusfile0_0.12-4_amd64.deb ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.656+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Unpacking libopusfile0:amd64 (0.12-4) ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.663+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Selecting previously unselected package libportmidi0:amd64. Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.741+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Preparing to unpack .../31-libportmidi0_1%3a217-6.1_amd64.deb ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.757+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Unpacking libportmidi0:amd64 (1:217-6.1) ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.772+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Selecting previously unselected package zlib1g-dev:amd64. Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.824+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Preparing to unpack .../32-zlib1g-dev_1%3a1.2.13.dfsg-1_amd64.deb ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.838+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Unpacking zlib1g-dev:amd64 (1:1.2.13.dfsg-1) ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.853+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Selecting previously unselected package libpython3.11-dev:amd64. Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.948+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Preparing to unpack .../33-libpython3.11-dev_3.11.2-6+deb12u8_amd64.deb ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.972+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:17 volumio volumio[1315]: info: Unpacking libpython3.11-dev:amd64 (3.11.2-6+deb12u8) ... Aug 28 15:20:17 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:17.990+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Selecting previously unselected package libpython3-dev:amd64. Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.159+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Preparing to unpack .../34-libpython3-dev_3.11.2-1+b1_amd64.deb ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.185+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Unpacking libpython3-dev:amd64 (3.11.2-1+b1) ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.205+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Selecting previously unselected package libsdl2-image-2.0-0:amd64. Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.257+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Preparing to unpack .../35-libsdl2-image-2.0-0_2.6.3+dfsg-1_amd64.deb ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.280+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Unpacking libsdl2-image-2.0-0:amd64 (2.6.3+dfsg-1) ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.294+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Selecting previously unselected package libsdl2-mixer-2.0-0:amd64. Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.364+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Preparing to unpack .../36-libsdl2-mixer-2.0-0_2.6.2+dfsg-2_amd64.deb ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.383+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Unpacking libsdl2-mixer-2.0-0:amd64 (2.6.2+dfsg-2) ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.428+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Selecting previously unselected package libsdl2-ttf-2.0-0:amd64. Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.554+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Preparing to unpack .../37-libsdl2-ttf-2.0-0_2.20.1+dfsg-2_amd64.deb ... Aug 28 15:20:19 volumio volumio[1315]: info: Unpacking libsdl2-ttf-2.0-0:amd64 (2.20.1+dfsg-2) ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.578+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.584+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Selecting previously unselected package manpages-dev. Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.624+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Preparing to unpack .../38-manpages-dev_6.03-2_all.deb ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.641+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:19 volumio volumio[1315]: info: Unpacking manpages-dev (6.03-2) ... Aug 28 15:20:19 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:19.657+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Selecting previously unselected package python3.11-dev. Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.211+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Preparing to unpack .../39-python3.11-dev_3.11.2-6+deb12u8_amd64.deb ... Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.220+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Unpacking python3.11-dev (3.11.2-6+deb12u8) ... Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.230+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Selecting previously unselected package python3-dev. Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.314+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Preparing to unpack .../40-python3-dev_3.11.2-1+b1_amd64.deb ... Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.327+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Unpacking python3-dev (3.11.2-1+b1) ... Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.338+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Selecting previously unselected package python3-numpy. Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.395+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Preparing to unpack .../41-python3-numpy_1%3a1.24.2-1+deb12u1_amd64.deb ... Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.409+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:22 volumio volumio[1315]: info: Unpacking python3-numpy (1:1.24.2-1+deb12u1) ... Aug 28 15:20:22 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:22.422+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:24 volumio volumio[1315]: info: Selecting previously unselected package python3-pygame. Aug 28 15:20:24 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:24.744+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:24 volumio volumio[1315]: info: Preparing to unpack .../42-python3-pygame_2.1.2+dfsg-5+b1_amd64.deb ... Aug 28 15:20:24 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:24.770+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:24 volumio volumio[1315]: info: Unpacking python3-pygame (2.1.2+dfsg-5+b1) ... Aug 28 15:20:24 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:24.794+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up libsdl2-image-2.0-0:amd64 (2.6.3+dfsg-1) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.318+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up libabsl20220623:amd64 (20220623.1-1+deb12u2) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.333+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up libc-l10n (2.36-9+deb12u14) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.344+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up manpages (6.03-2) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.362+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up fonts-freefont-ttf (20120503-10) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.377+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up linux-libc-dev:amd64 (6.1.176-1) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.381+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up libfftw3-long3:amd64 (3.3.10-1) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.392+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: Setting up locales (2.36-9+deb12u14) ... Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.402+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: debconf: unable to initialize frontend: Dialog Aug 28 15:20:25 volumio volumio[1315]: info: debconf: (Dialog frontend will not work on a dumb terminal, an emacs shell buffer, or without a controlling terminal.) Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.572+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.579+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: debconf: falling back to frontend: Readline Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.589+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: debconf: unable to initialize frontend: Readline Aug 28 15:20:25 volumio volumio[1315]: info: debconf: (This frontend requires a controlling tty.) Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.605+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio[1315]: info: debconf: falling back to frontend: Teletype Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.619+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:25 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:25.619+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:26 volumio volumio[1315]: info: Generating locales (this might take a while)... Aug 28 15:20:26 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:26.272+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: en_US.UTF-8... done Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.405+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Generation complete. Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.424+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libtirpc-dev:amd64 (1.3.3+ds-1) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.476+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up rpcsvc-proto (1.4.3-1) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.496+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libfftw3-quad3:amd64 (3.3.10-1) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.506+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libportmidi0:amd64 (1:217-6.1) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.519+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libgav1-1:amd64 (0.18.0-1+b1) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.533+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libfftw3-double3:amd64 (3.3.10-1) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.543+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libnsl-dev:amd64 (1.3.0-2) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.555+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libcrypt-dev:amd64 (1:4.4.33-2) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.564+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libsdl2-ttf-2.0-0:amd64 (2.20.1+dfsg-2) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.592+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libpython3.11-minimal:amd64 (3.11.2-6+deb12u8) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.604+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libc-dev-bin (2.36-9+deb12u14) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.628+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libyuv0:amd64 (0.0~git20230123.b2528b0-1) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.642+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up libopusfile0:amd64 (0.12-4) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.652+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:28 volumio volumio[1315]: info: Setting up python3.11-minimal (3.11.2-6+deb12u8) ... Aug 28 15:20:28 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:28.666+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up manpages-dev (6.03-2) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.143+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libavif15:amd64 (0.11.1-1+deb12u1) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.159+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libfftw3-bin (3.3.10-1) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.173+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libpython3.11-stdlib:amd64 (3.11.2-6+deb12u8) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.185+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libsdl2-mixer-2.0-0:amd64 (2.6.2+dfsg-2) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.194+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libgd3:amd64 (2.3.3-9) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.207+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libc6-dev:amd64 (2.36-9+deb12u14) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.213+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libfftw3-dev:amd64 (3.3.10-1) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.222+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up libc-devtools (2.36-9+deb12u14) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.233+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:30 volumio volumio[1315]: info: Setting up python3.11 (3.11.2-6+deb12u8) ... Aug 28 15:20:30 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:30.243+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:31 volumio volumio[1315]: info: Setting up libpython3.11:amd64 (3.11.2-6+deb12u8) ... Aug 28 15:20:31 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:31.651+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:31 volumio volumio[1315]: info: Setting up libexpat1-dev:amd64 (2.5.0-1+deb12u2) ... Aug 28 15:20:31 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:31.666+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:31 volumio volumio[1315]: info: Setting up libjpeg62-turbo-dev:amd64 (1:2.1.5-2) ... Aug 28 15:20:31 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:31.678+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:31 volumio volumio[1315]: info: Setting up python3-numpy (1:1.24.2-1+deb12u1) ... Aug 28 15:20:31 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:31.692+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Setting up zlib1g-dev:amd64 (1:1.2.13.dfsg-1) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.514+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Setting up python3-pygame (2.1.2+dfsg-5+b1) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.532+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Setting up libjpeg-dev:amd64 (1:2.1.5-2) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.832+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Setting up libpython3.11-dev:amd64 (3.11.2-6+deb12u8) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.847+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Setting up libpython3-dev:amd64 (3.11.2-1+b1) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.855+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Setting up python3.11-dev (3.11.2-6+deb12u8) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.869+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Setting up python3-dev (3.11.2-1+b1) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.878+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Processing triggers for libc-bin (2.36-9+deb12u14) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.887+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:34 volumio volumio[1315]: info: Processing triggers for systemd (252.39-1~deb12u1) ... Aug 28 15:20:34 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:34.953+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:35 volumio systemd[1]: Stopping systemd-binfmt.service - Set Up Additional Binary Formats... Aug 28 15:20:35 volumio systemd[1]: systemd-binfmt.service: Deactivated successfully. Aug 28 15:20:35 volumio systemd[1]: Stopped systemd-binfmt.service - Set Up Additional Binary Formats. Aug 28 15:20:35 volumio systemd[1]: Starting systemd-binfmt.service - Set Up Additional Binary Formats... Aug 28 15:20:35 volumio systemd[1]: Finished systemd-binfmt.service - Set Up Additional Binary Formats. Aug 28 15:20:35 volumio volumio[1315]: info: Processing triggers for man-db (2.11.2-2) ... Aug 28 15:20:35 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:35.083+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:35 volumio volumio[1315]: info: Processing triggers for fontconfig (2.14.1-4) ... Aug 28 15:20:35 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:35.813+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:36 volumio sudo[4207]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:36 volumio sudo[5596]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Aug 28 15:20:36 volumio sudo[5596]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 15:20:36 volumio systemd[1]: Reloading. Aug 28 15:20:36 volumio systemd-gpt-auto-generator[5605]: EFI loader partition unknown, exiting. Aug 28 15:20:36 volumio systemd-gpt-auto-generator[5605]: (The boot loader did not set EFI variable LoaderDevicePartUUID.) Aug 28 15:20:36 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. Aug 28 15:20:36 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. Aug 28 15:20:36 volumio sudo[5596]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:36 volumio volumio[1315]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/x86_64/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so Aug 28 15:20:36 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:36.541+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:36 volumio volumio[1315]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/x86_64/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so.0 Aug 28 15:20:36 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:36.545+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:37 volumio sudo[5617]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/user_interface/peppymeterbasic/startpeppymeterbasic.sh Aug 28 15:20:37 volumio sudo[5617]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 15:20:37 volumio sudo[5617]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:37 volumio sudo[4079]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:37 volumio volumio[1315]: Plugin install end detected on script Aug 28 15:20:37 volumio volumio[1315]: info: Install script completed Aug 28 15:20:37 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:37.490+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:37 volumio volumio[1315]: info: Adding reference to registry Aug 28 15:20:37 volumio volumio5-onboarding[2404]: time=2026-08-28T15:20:37.493+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Aug 28 15:20:37 volumio volumio[1315]: info: Done installing plugin. Aug 28 15:20:37 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 28 15:20:37 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 28 15:20:37 volumio volumio[1315]: info: Folder /tmp/plugins removed Aug 28 15:20:37 volumio volumio[1315]: info: Folder /tmp/downloaded_plugin.zip removed Aug 28 15:20:37 volumio volumio[1315]: info: Folder /data/temp removed Aug 28 15:20:39 volumio volumio[1315]: info: Enabling plugin peppymeterbasic Aug 28 15:20:39 volumio volumio[1315]: info: Loading plugin "peppymeterbasic"... Aug 28 15:20:39 volumio volumio[1315]: info: Preparing to generate the ALSA configuration file Aug 28 15:20:39 volumio volumio[1315]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 28 15:20:39 volumio volumio[1315]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Aug 28 15:20:39 volumio volumio[1315]: info: Reading ALSA contributions from plugins. Aug 28 15:20:39 volumio volumio[1315]: info: Asound.conf file written Aug 28 15:20:39 volumio sudo[5623]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 28 15:20:39 volumio sudo[5623]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:39 volumio sudo[5623]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:39 volumio volumio[1315]: info: Output device has changed, restarting MPD Aug 28 15:20:39 volumio volumio[1315]: info: Output device has changed, restarting Shairport Sync Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 15:20:39 volumio sudo[5629]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 15:20:39 volumio sudo[5629]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:39 volumio sudo[5629]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:39 volumio sudo[5631]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 15:20:39 volumio sudo[5631]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:39 volumio volumio[1315]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 28 15:20:39 volumio volumio[1315]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 28 15:20:39 volumio volumio[1315]: info: QobuzConnect: setDeactiveState invoked Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:20:39 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:39 volumio vtcs[2347]: [2026-08-28 15:20:39.814] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Aug 28 15:20:39 volumio vtcs[2347]: [2026-08-28 15:20:39.814] [tisoc] [error] [SpkconServer.cpp:383] recv error. client fd=8 errorno=104 error=Connection reset by peer Aug 28 15:20:39 volumio vtcs[2347]: [2026-08-28 15:20:39.814] [tisoc] [error] [SpkconServer.cpp:378] recv error. socket disconnected Aug 28 15:20:39 volumio volumio[1315]: info: PLUGIN START: peppymeterbasic Aug 28 15:20:39 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 15:20:39 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 15:20:39 volumio systemd[1]: mpd.service: Consumed 3.200s CPU time. Aug 28 15:20:39 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 15:20:39 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 15:20:39 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 15:20:39 volumio sudo[5641]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 15:20:39 volumio sudo[5641]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 28 15:20:39 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 15:20:39 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 15:20:39 volumio volumio[1315]: info: Preparing to generate the ALSA configuration file Aug 28 15:20:39 volumio systemd[1]: Stopping vtcs.service - Volumio Tidal Connect Service... Aug 28 15:20:39 volumio systemd[1]: vtcs.service: Deactivated successfully. Aug 28 15:20:39 volumio systemd[1]: Stopped vtcs.service - Volumio Tidal Connect Service. Aug 28 15:20:39 volumio sudo[5646]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Aug 28 15:20:39 volumio sudo[5646]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:39 volumio volumio[1315]: info: Done. Aug 28 15:20:39 volumio sudo[5641]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Aug 28 15:20:39 volumio volumio[1315]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Aug 28 15:20:39 volumio volumio[1315]: info: Reading ALSA contributions from plugins. Aug 28 15:20:39 volumio sudo[5650]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 15:20:39 volumio sudo[5650]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:39 volumio sudo[5646]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:39 volumio sudo[5645]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 15:20:39 volumio sudo[5656]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 28 15:20:39 volumio sudo[5645]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 15:20:39 volumio sudo[5656]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:39 volumio sudo[5645]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:39 volumio volumio[1315]: info: MPD Permissions set Aug 28 15:20:39 volumio volumio[1315]: info: snd_dummy loaded Aug 28 15:20:39 volumio volumio[1315]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:39 volumio (udev-worker)[5662]: controlC7: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 7' failed with exit code 99. Aug 28 15:20:40 volumio sudo[5650]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 28 15:20:40 volumio sudo[5656]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio sudo[5675]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 28 15:20:40 volumio sudo[5675]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 28 15:20:40 volumio qobuz-connect[2250]: 20260828 15:20:40.066 [2250.2250] INFO SampleApp: Stopping Local configuration server Aug 28 15:20:40 volumio volumio[1315]: info: Starting Shairport Sync Aug 28 15:20:40 volumio sudo[5681]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 28 15:20:40 volumio sudo[5681]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio volumio[1315]: info: Asound.conf file unchanged, so no further update is needed Aug 28 15:20:40 volumio volumio[1315]: info: Output device has changed, restarting MPD Aug 28 15:20:40 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 28 15:20:40 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 28 15:20:40 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 28 15:20:40 volumio systemd[1]: shairport-sync.service: Consumed 3.800s CPU time. Aug 28 15:20:40 volumio volumio[1315]: info: Output device has changed, restarting Shairport Sync Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 15:20:40 volumio sudo[5684]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 28 15:20:40 volumio sudo[5684]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 28 15:20:40 volumio sudo[5681]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio sudo[5684]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio sudo[5687]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 28 15:20:40 volumio sudo[5687]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio volumio[1315]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 28 15:20:40 volumio volumio[1315]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: QobuzConnect: setDeactiveState invoked Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:20:40 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:40 volumio sudo[5711]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 15:20:40 volumio sudo[5711]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio systemd[1]: mpd.service: Deactivated successfully. Aug 28 15:20:40 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 28 15:20:40 volumio systemd[1]: mpd.socket: Deactivated successfully. Aug 28 15:20:40 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 28 15:20:40 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 28 15:20:40 volumio sudo[5716]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 28 15:20:40 volumio sudo[5716]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 15:20:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 28 15:20:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Aug 28 15:20:40 volumio volumio[1315]: info: MPD Permissions set Aug 28 15:20:40 volumio volumio[1315]: info: Shairport-Sync Started Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio sudo[5726]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 28 15:20:40 volumio sudo[5726]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio sudo[5711]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio sudo[5716]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio sudo[5725]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 28 15:20:40 volumio sudo[5725]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 28 15:20:40 volumio sudo[5725]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Aug 28 15:20:40 volumio sudo[5726]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 28 15:20:40 volumio volumio[1315]: info: Starting Shairport Sync Aug 28 15:20:40 volumio sudo[5740]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 28 15:20:40 volumio sudo[5740]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio qobuz-connect[2250]: 20260828 15:20:40.453 [2250.2250] INFO SampleApp: shat down connection on UNIX socket Aug 28 15:20:40 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 28 15:20:40 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 28 15:20:40 volumio volumio[1315]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Aug 28 15:20:40 volumio volumio[1315]: info: QobuzConnect: setDeactiveState invoked Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:20:40 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:40 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 28 15:20:40 volumio sudo[5675]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 28 15:20:40 volumio systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 28 15:20:40 volumio systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 28 15:20:40 volumio sudo[5744]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 28 15:20:40 volumio sudo[5744]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:40 volumio systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 28 15:20:40 volumio sudo[5740]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Aug 28 15:20:40 volumio volumio[1315]: info: Executing endpoint qc_getconfig Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 28 15:20:40 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Aug 28 15:20:40 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.594 [5745.5745] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.597 [5745.5745] INFO VolumeManager: [0x556c10514e90]: Setting new playback volume: 75 Aug 28 15:20:40 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.597 [5745.5745] INFO VolumeManager: [0x556c10514e90]: Setting new mute state: 0 Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.602 [5745.5745] INFO AudioStreamManager: [0x556c105149f0]: Setting new audio download buffer size: 1048576 Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.602 [5745.5745] INFO QobuzConnect: [0x556c10515ea0]: Client initialized! Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.602 [5745.5745] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Aug 28 15:20:40 volumio volumio[1315]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Aug 28 15:20:40 volumio volumio[1315]: info: QobuzConnect: QOBUZ Connect daemon connected Aug 28 15:20:40 volumio sudo[5744]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.612 [5745.5745] INFO LocalConfigManager: [0x556c105144d0]: Starting Local Configuration server Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.612 [5745.5745] INFO SampleApp: Starting Local configuration server Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.612 [5745.5745] INFO SampleApp: Connected to UNIX socket client 0x556c104eabb0 Aug 28 15:20:40 volumio volumio[1315]: info: Shairport-Sync Started Aug 28 15:20:40 volumio qobuz-connect[5745]: 20260828 15:20:40.743 [5745.5745] INFO SampleApp: Playback volume changed: 75 Aug 28 15:20:40 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:20:40 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:41 volumio mpd[5736]: 2026-08-28T15:20:41 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 28 15:20:41 volumio systemd[1]: Started mpd.service - Music Player Daemon. Aug 28 15:20:41 volumio sudo[5631]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:41 volumio sudo[5687]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:41 volumio volumio[1315]: error: MPD error: The expression evaluated to a falsy value: Aug 28 15:20:41 volumio volumio[1315]: assert.ok(self.idling) Aug 28 15:20:41 volumio volumio[1315]: error: The expression evaluated to a falsy value: Aug 28 15:20:41 volumio volumio[1315]: assert.ok(self.idling) Aug 28 15:20:41 volumio volumio[1315]: error: updateQueue error: null Aug 28 15:20:42 volumio volumio[1315]: info: TidalConnect service stoped! Aug 28 15:20:43 volumio volumio[1315]: info: TidalConnect service stoped! Aug 28 15:20:43 volumio volumio[1315]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 28 15:20:43 volumio volumio[1315]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 28 15:20:43 volumio sudo[5782]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 28 15:20:43 volumio sudo[5782]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:43 volumio systemd[1]: Started vtcs.service - Volumio Tidal Connect Service. Aug 28 15:20:43 volumio sudo[5782]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:43 volumio volumio[1315]: info: Executing endpoint tc_getconfig Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Aug 28 15:20:43 volumio vtcs[5799]: STARTING TidalConnect services, version: 1.6.1 Aug 28 15:20:43 volumio vtcs[5799]: [2026-08-28 15:20:43.167] [tisoc] [critical] [DeviceInfo.cpp:52] ioctl error. ret=-1, errno="No such device" Aug 28 15:20:43 volumio vtcs[5799]: [2026-08-28 15:20:43.168] [tisoc] [critical] [DeviceInfo.cpp:53] [ASSERT] generateDeviceId(0) Aug 28 15:20:43 volumio vtcs[5799]: STARTED TidalConnect services. Aug 28 15:20:43 volumio volumio[1315]: info: Executing endpoint tc_connect Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Aug 28 15:20:43 volumio volumio[1315]: info: Connecting to TidalConnect Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:20:43 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:20:43 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:20:43 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:20:43 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:20:43 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:43 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:43 volumio volumio[1315]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:20:43 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:20:43 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:20:43 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:20:43 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:20:43 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:20:43 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:43 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:43 volumio volumio[1315]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Aug 28 15:20:43 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:20:43 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:20:43 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:20:43 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:20:43 volumio sudo[5816]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:20:43 volumio sudo[5816]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:43 volumio sudo[5819]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:20:43 volumio sudo[5816]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:43 volumio sudo[5819]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:43 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:20:43 volumio sudo[5819]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:43 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:20:43 volumio volumio[1315]: info: TidalConnect service stoped! Aug 28 15:20:43 volumio volumio[1315]: info: TidalConnect service stoped! Aug 28 15:20:43 volumio volumio[1315]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Aug 28 15:20:43 volumio volumio[1315]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Aug 28 15:20:43 volumio sudo[5830]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Aug 28 15:20:43 volumio sudo[5830]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:20:43 volumio sudo[5830]: pam_unix(sudo:session): session closed for user root Aug 28 15:20:46 volumio volumio[1315]: info: TidalConnect service started! Aug 28 15:20:46 volumio volumio[1315]: info: TidalConnect service started! Aug 28 15:20:53 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:20:53 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:20:55 volumio volumio[1315]: info: Executing endpoint metavolumio Aug 28 15:20:55 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 28 15:20:55 volumio volumio[1315]: info: Executing endpoint metavolumio Aug 28 15:20:55 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 28 15:20:55 volumio volumio[1315]: info: Executing endpoint metavolumio Aug 28 15:20:55 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 15:20:59 volumio volumio[1315]: info: Retrieving Cloud Streaming UI Aug 28 15:20:59 volumio volumio[1315]: info: Getting Tidal Cloud Configuration Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 15:20:59 volumio volumio[1315]: info: Getting Qobuz Cloud Configuration Aug 28 15:20:59 volumio volumio[1315]: info: Asking plugin for UI Config Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 15:20:59 volumio volumio[1315]: info: Getting Spotify Cloud Configuration Aug 28 15:20:59 volumio volumio[1315]: info: Asking plugin for UI Config Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 15:20:59 volumio volumio[1315]: info: Saving Spotify Acccount Aug 28 15:20:59 volumio volumio[1315]: info: Got it Aug 28 15:20:59 volumio volumio[1315]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 28 15:20:59 volumio volumio[1315]: info: Got Tidal Cloud Configuration Aug 28 15:20:59 volumio volumio[1315]: info: Got it Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::volumioGetBrowseSources Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::volumioGetBrowseSources Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::volumioGetBrowseSources Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:20:59 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand update Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:01 volumio volumio[1315]: info: Aug 28 15:21:01 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:01 volumio volumio[1315]: info: sendMpdCommand update took 5 milliseconds Aug 28 15:21:01 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:01 volumio volumio[1315]: info: Aug 28 15:21:01 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:01 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:01 volumio volumio[1315]: info: sendMpdCommand status took 9 milliseconds Aug 28 15:21:01 volumio volumio[1315]: info: sendMpdCommand status took 9 milliseconds Aug 28 15:21:01 volumio volumio[1315]: info: sendMpdCommand status took 9 milliseconds Aug 28 15:21:01 volumio volumio[1315]: info: sendMpdCommand status took 9 milliseconds Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:01 volumio volumio[1315]: info: Command Router : Notfying DB Updatetrue Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:01 volumio volumio[1315]: info: Command Router : Notfying DB Updatetrue Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:01 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:01 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:01 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:01 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:01 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:01 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:01 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:01 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:01 volumio volumio[1315]: info: ------------------------------ 514ms Aug 28 15:21:01 volumio volumio[1315]: info: ------------------------------ 515ms Aug 28 15:21:01 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:01 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:01 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:01 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:01 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:01 volumio sudo[5885]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:01 volumio sudo[5885]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:01 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:01 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:01 volumio sudo[5888]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:01 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:01 volumio sudo[5885]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:01 volumio sudo[5888]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:01 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:01 volumio sudo[5890]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:01 volumio sudo[5890]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:01 volumio sudo[5893]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:01 volumio sudo[5893]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:01 volumio sudo[5888]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:01 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:02 volumio sudo[5890]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:02 volumio sudo[5893]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:02 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:02 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: info: Aug 28 15:21:02 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: info: Aug 28 15:21:02 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 1 milliseconds Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 1 milliseconds Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: info: Command Router : Notfying DB Updatefalse Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:02 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: ------------------------------ 56ms Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 56 milliseconds Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 55 milliseconds Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: info: Command Router : Notfying DB Updatefalse Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:02 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: ------------------------------ 85ms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:02 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:02 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:02 volumio sudo[5904]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:02 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:02 volumio sudo[5904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:02 volumio sudo[5908]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:02 volumio sudo[5908]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:02 volumio sudo[5906]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:02 volumio sudo[5906]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:02 volumio sudo[5911]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:02 volumio sudo[5911]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:02 volumio sudo[5904]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:02 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:02 volumio sudo[5908]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:02 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:02 volumio sudo[5911]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:02 volumio sudo[5906]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:02 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:02 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand rescan Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: info: Aug 28 15:21:02 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand rescan took 4 milliseconds Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: info: Aug 28 15:21:02 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 4 milliseconds Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 3 milliseconds Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 1 milliseconds Aug 28 15:21:02 volumio volumio[1315]: info: sendMpdCommand status took 0 milliseconds Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: info: Command Router : Notfying DB Updatetrue Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: info: Command Router : Notfying DB Updatetrue Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:02 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:02 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:02 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:02 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:02 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:02 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:02 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:02 volumio volumio[1315]: info: ------------------------------ 86ms Aug 28 15:21:02 volumio volumio[1315]: info: ------------------------------ 88ms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:02 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:02 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:02 volumio sudo[5923]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:02 volumio sudo[5923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:02 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:02 volumio sudo[5925]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:03 volumio sudo[5925]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:03 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:03 volumio sudo[5923]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:03 volumio sudo[5929]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:03 volumio sudo[5925]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:03 volumio sudo[5929]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:03 volumio volumio[1315]: error: Failed request for metavolumio API Aug 28 15:21:03 volumio volumio[1315]: error: Failed request for metavolumio API Aug 28 15:21:03 volumio volumio[1315]: error: Failed request for metavolumio API Aug 28 15:21:03 volumio sudo[5932]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:03 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:03 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:03 volumio sudo[5932]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:03 volumio sudo[5929]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:03 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:03 volumio sudo[5932]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:03 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:03 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:21:04 volumio volumio[1315]: info: MPD Database updated - AlbumList cache refreshed Aug 28 15:21:04 volumio volumio[1315]: info: Aug 28 15:21:04 volumio volumio[1315]: ---------------------------- MPD announces state update: database Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:04 volumio volumio[1315]: info: Aug 28 15:21:04 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:04 volumio volumio[1315]: info: MPD Database updated - AlbumList cache refreshed Aug 28 15:21:04 volumio volumio[1315]: info: Aug 28 15:21:04 volumio volumio[1315]: ---------------------------- MPD announces state update: database Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:04 volumio volumio[1315]: info: Aug 28 15:21:04 volumio volumio[1315]: ---------------------------- MPD announces state update: update Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::getState Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::sendMpdCommand status Aug 28 15:21:04 volumio volumio[1315]: info: sendMpdCommand status took 6 milliseconds Aug 28 15:21:04 volumio volumio[1315]: info: sendMpdCommand status took 5 milliseconds Aug 28 15:21:04 volumio volumio[1315]: info: sendMpdCommand status took 5 milliseconds Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:04 volumio volumio[1315]: info: Command Router : Notfying DB Updatefalse Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:04 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:04 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: ------------------------------ 33ms Aug 28 15:21:04 volumio volumio[1315]: info: ------------------------------ 33ms Aug 28 15:21:04 volumio volumio[1315]: info: sendMpdCommand status took 35 milliseconds Aug 28 15:21:04 volumio volumio[1315]: info: sendMpdCommand status took 34 milliseconds Aug 28 15:21:04 volumio volumio[1315]: info: sendMpdCommand status took 34 milliseconds Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:04 volumio volumio[1315]: info: Command Router : Notfying DB Updatefalse Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::Close All Modals sent Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:04 volumio volumio[1315]: verbose: ControllerMpd::parseState Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:04 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: ControllerMpd::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::servicePushState Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 28 15:21:04 volumio volumio[1315]: verbose: CURRENT POSITION 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState stateService stop Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::syncState currentStatus pause Aug 28 15:21:04 volumio volumio[1315]: info: CoreStateMachine::pushState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioPushState Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output update for this device Aug 28 15:21:04 volumio volumio[1315]: info: MRS: Pushing multiroomSync output Aug 28 15:21:04 volumio volumio[1315]: info: CoreCommandRouter::volumioGetState Aug 28 15:21:04 volumio volumio[1315]: info: CorePlayQueue::getTrack 0 Aug 28 15:21:04 volumio volumio[1315]: info: ------------------------------ 66ms Aug 28 15:21:04 volumio volumio[1315]: info: ------------------------------ 66ms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: Display-configuration --- Volumio status=pause timeout=120 noifplay=true screensavertype=dpms Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio sudo[5959]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio sudo[5959]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio sudo[5962]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio sudo[5962]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio sudo[5959]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio sudo[5964]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio sudo[5964]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio sudo[5968]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio sudo[5968]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio sudo[5962]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio sudo[5970]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio volumio[1315]: info: PeppyMeterBasic ---peppymeterbasic status pause Aug 28 15:21:04 volumio sudo[5970]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio sudo[5968]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio sudo[5964]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio sudo[5973]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio sudo[5973]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio sudo[5970]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio sudo[5976]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio sudo[5976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio sudo[5973]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:04 volumio sudo[5979]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:04 volumio sudo[5979]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 28 15:21:04 volumio sudo[5976]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio sudo[5979]: pam_unix(sudo:session): session closed for user root Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:04 volumio volumio[1315]: info: peppymeterbasic Daemon Stop Aug 28 15:21:07 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:21:11 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:21:15 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:21:19 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:21:23 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:21:27 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 28 15:21:27 volumio volumio[1315]: info: CALLMETHOD: miscellanea albumart clearAlbumartCache Aug 28 15:21:27 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: albumart , clearAlbumartCache Aug 28 15:21:27 volumio volumio[1315]: info: CoreCommandRouter::executeOnPlugin: mpd , rebuildAlbumCache Aug 28 15:21:27 volumio volumio[1315]: info: Rebuild Album cache Aug 28 15:21:28 volumio volumio[1315]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 15:21:28 volumio volumio[1315]: [Error: ENOENT: no such file or directory, open '/data/albumart/web/ROBOT%20DEATH%20MONKEY/Intergalactic%20Party%20Powder/48b61eac-a336-4398-b5d8-07a313507d87.jpg'] { Aug 28 15:21:28 volumio volumio[1315]: errno: -2, Aug 28 15:21:28 volumio volumio[1315]: code: 'ENOENT', Aug 28 15:21:28 volumio volumio[1315]: syscall: 'open', Aug 28 15:21:28 volumio volumio[1315]: path: '/data/albumart/web/ROBOT%20DEATH%20MONKEY/Intergalactic%20Party%20Powder/48b61eac-a336-4398-b5d8-07a313507d87.jpg' Aug 28 15:21:28 volumio volumio[1315]: } Aug 28 15:21:28 volumio volumio[1315]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 28 15:21:28 volumio sudo[6052]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-28 15:20' Aug 28 15:21:28 volumio sudo[6052]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"