Feb 18 11:15:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 11:15:06 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 11:15:25 volumio volumio[1087]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/peppyspectrum/volumio/bookworm/amd64 Feb 18 11:15:25 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:25.777+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:26 volumio volumio[1087]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/peppyspectrum/volumio/bookworm/amd64 Feb 18 11:15:26 volumio volumio[1087]: info: Folder /tmp/plugins removed Feb 18 11:15:26 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:26.871+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:26 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:26.967+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:26 volumio volumio[1087]: info: Check plugin dependencies Feb 18 11:15:26 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 18 11:15:26 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:26.982+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:26 volumio volumio[1087]: info: Checking if plugin already exists Feb 18 11:15:26 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:26.987+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:26 volumio volumio[1087]: info: Rename folder Feb 18 11:15:26 volumio volumio[1087]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 11:15:27 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:27.001+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:27 volumio volumio[1087]: info: Move to category Feb 18 11:15:27 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:27.058+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:27 volumio volumio[1087]: info: Checking if install.sh is present Feb 18 11:15:27 volumio volumio[1087]: info: Executing install.sh Feb 18 11:15:27 volumio sudo[3692]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/peppyspectrum/install.sh Feb 18 11:15:27 volumio sudo[3692]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:27 volumio volumio[1087]: info: Installing peppyalsa plugin dependencies Feb 18 11:15:27 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:27.092+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:27 volumio sudo[3696]: root : PWD=/ ; USER=root ; COMMAND=/usr/sbin/usermod -aG render volumio Feb 18 11:15:27 volumio sudo[3696]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:27 volumio usermod[3697]: add 'volumio' to group 'render' Feb 18 11:15:27 volumio usermod[3697]: add 'volumio' to shadow group 'render' Feb 18 11:15:27 volumio sudo[3696]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:27 volumio sudo[3704]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update Feb 18 11:15:27 volumio sudo[3704]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:27 volumio volumio[1087]: info: Hit:1 http://deb.debian.org/debian bookworm InRelease Feb 18 11:15:27 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:27.266+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:29 volumio volumio[1087]: info: Reading package lists... Feb 18 11:15:29 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:29.103+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:29 volumio sudo[3704]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:29 volumio sudo[3812]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chown -R volumio /data/plugins/user_interface/peppyspectrum /data/INTERNAL/PeppySpectrum/Templates Feb 18 11:15:29 volumio sudo[3812]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:29 volumio sudo[3812]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:29 volumio sudo[3814]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chgrp -R volumio /data/plugins/user_interface/peppyspectrum /data/INTERNAL/PeppySpectrum/Templates Feb 18 11:15:29 volumio sudo[3814]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:29 volumio sudo[3814]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:29 volumio volumio[1087]: info: installing apt packages Feb 18 11:15:29 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:29.173+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:29 volumio sudo[3816]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -y install python3-pygame python3-pillow libfftw3-dev Feb 18 11:15:29 volumio sudo[3816]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:29 volumio volumio[1087]: info: Reading package lists... Feb 18 11:15:29 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:29.223+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:29 volumio volumio[1087]: info: Building dependency tree... Feb 18 11:15:29 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:29.589+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:29 volumio volumio[1087]: info: Reading state information... Feb 18 11:15:29 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:29.595+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: The following additional packages will be installed: Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.021+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: bzip2 file fonts-freefont-ttf libfftw3-bin libfftw3-double3 libfftw3-long3 Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.029+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: libfftw3-quad3 libimagequant0 libopusfile0 libportmidi0 libraqm0 Feb 18 11:15:30 volumio volumio[1087]: info: libsdl2-image-2.0-0 libsdl2-mixer-2.0-0 libsdl2-ttf-2.0-0 mailcap Feb 18 11:15:30 volumio volumio[1087]: info: mime-support python3-numpy python3-olefile Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.035+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.035+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.036+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Suggested packages: Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.053+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: bzip2-doc libfftw3-doc gcc gfortran python3-dev python3-pytest Feb 18 11:15:30 volumio volumio[1087]: info: python-pil-doc python-pygame-doc timidity Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.057+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.058+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: The following NEW packages will be installed: Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.085+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: bzip2 file fonts-freefont-ttf libfftw3-bin libfftw3-dev libfftw3-double3 Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.090+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: libfftw3-long3 libfftw3-quad3 libimagequant0 libopusfile0 libportmidi0 Feb 18 11:15:30 volumio volumio[1087]: info: libraqm0 libsdl2-image-2.0-0 libsdl2-mixer-2.0-0 libsdl2-ttf-2.0-0 mailcap Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.098+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.099+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: mime-support python3-numpy python3-olefile python3-pil python3-pygame Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.114+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: 0 upgraded, 21 newly installed, 0 to remove and 0 not upgraded. Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.153+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Need to get 13.3 MB of archives. Feb 18 11:15:30 volumio volumio[1087]: info: After this operation, 62.4 MB of additional disk space will be used. Feb 18 11:15:30 volumio volumio[1087]: info: Get:1 http://deb.debian.org/debian bookworm/main amd64 bzip2 amd64 1.0.8-5+b1 [49.8 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.159+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.160+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.160+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:2 http://deb.debian.org/debian bookworm/main amd64 file amd64 1:5.44-3 [42.5 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.173+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:3 http://deb.debian.org/debian bookworm/main amd64 mailcap all 3.70+nmu1 [32.0 kB] Feb 18 11:15:30 volumio volumio[1087]: info: Get:4 http://deb.debian.org/debian bookworm/main amd64 mime-support all 3.66 [10.9 kB] Feb 18 11:15:30 volumio volumio[1087]: info: Get:5 http://deb.debian.org/debian bookworm/main amd64 fonts-freefont-ttf all 20120503-10 [2552 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.181+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.181+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.181+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:6 http://deb.debian.org/debian bookworm/main amd64 libfftw3-double3 amd64 3.3.10-1 [776 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.210+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:7 http://deb.debian.org/debian bookworm/main amd64 libfftw3-long3 amd64 3.3.10-1 [337 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.223+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:8 http://deb.debian.org/debian bookworm/main amd64 libfftw3-quad3 amd64 3.3.10-1 [603 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.230+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:9 http://deb.debian.org/debian bookworm/main amd64 libfftw3-bin amd64 3.3.10-1 [51.7 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.239+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:10 http://deb.debian.org/debian bookworm/main amd64 libfftw3-dev amd64 3.3.10-1 [2123 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.245+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:11 http://deb.debian.org/debian bookworm/main amd64 libimagequant0 amd64 2.17.0-1 [32.5 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.271+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:12 http://deb.debian.org/debian bookworm/main amd64 libopusfile0 amd64 0.12-4 [41.8 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.279+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:13 http://deb.debian.org/debian bookworm/main amd64 libportmidi0 amd64 1:217-6.1 [22.6 kB] Feb 18 11:15:30 volumio volumio[1087]: info: Get:14 http://deb.debian.org/debian bookworm/main amd64 libraqm0 amd64 0.7.0-4.1 [10.6 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.285+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.285+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:15 http://deb.debian.org/debian bookworm/main amd64 libsdl2-image-2.0-0 amd64 2.6.3+dfsg-1 [63.6 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.297+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:16 http://deb.debian.org/debian bookworm/main amd64 libsdl2-mixer-2.0-0 amd64 2.6.2+dfsg-2 [78.9 kB] Feb 18 11:15:30 volumio volumio[1087]: info: Get:17 http://deb.debian.org/debian bookworm/main amd64 libsdl2-ttf-2.0-0 amd64 2.20.1+dfsg-2 [34.8 kB] Feb 18 11:15:30 volumio volumio[1087]: info: Get:18 http://deb.debian.org/debian bookworm/main amd64 python3-numpy amd64 1:1.24.2-1+deb12u1 [4960 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.303+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.303+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.304+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:19 http://deb.debian.org/debian bookworm/main amd64 python3-olefile all 0.46-3 [36.1 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.350+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:20 http://deb.debian.org/debian bookworm/main amd64 python3-pil amd64 9.4.0-1.1+deb12u1 [472 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.358+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Get:21 http://deb.debian.org/debian bookworm/main amd64 python3-pygame amd64 2.1.2+dfsg-5+b1 [1013 kB] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.365+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Fetched 13.3 MB in 0s (53.8 MB/s) Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.789+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Selecting previously unselected package bzip2. Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.830+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: [620B blob data] Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.866+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Preparing to unpack .../00-bzip2_1.0.8-5+b1_amd64.deb ... Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.874+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:30 volumio volumio[1087]: info: Unpacking bzip2 (1.0.8-5+b1) ... Feb 18 11:15:30 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:30.881+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Selecting previously unselected package file. Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.015+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Preparing to unpack .../01-file_1%3a5.44-3_amd64.deb ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.023+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Unpacking file (1:5.44-3) ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.031+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Selecting previously unselected package mailcap. Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.174+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Preparing to unpack .../02-mailcap_3.70+nmu1_all.deb ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.182+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Unpacking mailcap (3.70+nmu1) ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.194+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Selecting previously unselected package mime-support. Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.408+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Preparing to unpack .../03-mime-support_3.66_all.deb ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.418+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Unpacking mime-support (3.66) ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.428+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Selecting previously unselected package fonts-freefont-ttf. Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.502+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Preparing to unpack .../04-fonts-freefont-ttf_20120503-10_all.deb ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.510+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:31 volumio volumio[1087]: info: Unpacking fonts-freefont-ttf (20120503-10) ... Feb 18 11:15:31 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:31.518+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Selecting previously unselected package libfftw3-double3:amd64. Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.040+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Preparing to unpack .../05-libfftw3-double3_3.3.10-1_amd64.deb ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.049+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Unpacking libfftw3-double3:amd64 (3.3.10-1) ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.072+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Selecting previously unselected package libfftw3-long3:amd64. Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.284+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Preparing to unpack .../06-libfftw3-long3_3.3.10-1_amd64.deb ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.293+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Unpacking libfftw3-long3:amd64 (3.3.10-1) ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.307+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Selecting previously unselected package libfftw3-quad3:amd64. Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.452+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Preparing to unpack .../07-libfftw3-quad3_3.3.10-1_amd64.deb ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.460+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Unpacking libfftw3-quad3:amd64 (3.3.10-1) ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.472+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Selecting previously unselected package libfftw3-bin. Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.657+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Preparing to unpack .../08-libfftw3-bin_3.3.10-1_amd64.deb ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.665+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Unpacking libfftw3-bin (3.3.10-1) ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.677+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Selecting previously unselected package libfftw3-dev:amd64. Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.806+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Preparing to unpack .../09-libfftw3-dev_3.3.10-1_amd64.deb ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.815+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:32 volumio volumio[1087]: info: Unpacking libfftw3-dev:amd64 (3.3.10-1) ... Feb 18 11:15:32 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:32.824+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Selecting previously unselected package libimagequant0:amd64. Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.478+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Preparing to unpack .../10-libimagequant0_2.17.0-1_amd64.deb ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.486+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Unpacking libimagequant0:amd64 (2.17.0-1) ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.496+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Selecting previously unselected package libopusfile0:amd64. Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.597+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Preparing to unpack .../11-libopusfile0_0.12-4_amd64.deb ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.605+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Unpacking libopusfile0:amd64 (0.12-4) ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.613+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Selecting previously unselected package libportmidi0:amd64. Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.714+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Preparing to unpack .../12-libportmidi0_1%3a217-6.1_amd64.deb ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.722+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Unpacking libportmidi0:amd64 (1:217-6.1) ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.730+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Selecting previously unselected package libraqm0:amd64. Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.828+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Preparing to unpack .../13-libraqm0_0.7.0-4.1_amd64.deb ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.836+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Unpacking libraqm0:amd64 (0.7.0-4.1) ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.844+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Selecting previously unselected package libsdl2-image-2.0-0:amd64. Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.926+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Preparing to unpack .../14-libsdl2-image-2.0-0_2.6.3+dfsg-1_amd64.deb ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.935+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:33 volumio volumio[1087]: info: Unpacking libsdl2-image-2.0-0:amd64 (2.6.3+dfsg-1) ... Feb 18 11:15:33 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:33.949+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Selecting previously unselected package libsdl2-mixer-2.0-0:amd64. Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.039+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Preparing to unpack .../15-libsdl2-mixer-2.0-0_2.6.2+dfsg-2_amd64.deb ... Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.047+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Unpacking libsdl2-mixer-2.0-0:amd64 (2.6.2+dfsg-2) ... Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.057+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Selecting previously unselected package libsdl2-ttf-2.0-0:amd64. Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.155+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Preparing to unpack .../16-libsdl2-ttf-2.0-0_2.20.1+dfsg-2_amd64.deb ... Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.163+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Unpacking libsdl2-ttf-2.0-0:amd64 (2.20.1+dfsg-2) ... Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.176+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Selecting previously unselected package python3-numpy. Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.268+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Preparing to unpack .../17-python3-numpy_1%3a1.24.2-1+deb12u1_amd64.deb ... Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.277+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:34 volumio volumio[1087]: info: Unpacking python3-numpy (1:1.24.2-1+deb12u1) ... Feb 18 11:15:34 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:34.284+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:39 volumio volumio[1087]: info: Selecting previously unselected package python3-olefile. Feb 18 11:15:39 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:39.479+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:39 volumio volumio[1087]: info: Preparing to unpack .../18-python3-olefile_0.46-3_all.deb ... Feb 18 11:15:39 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:39.488+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:39 volumio volumio[1087]: info: Unpacking python3-olefile (0.46-3) ... Feb 18 11:15:39 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:39.500+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:39 volumio volumio[1087]: info: Selecting previously unselected package python3-pil:amd64. Feb 18 11:15:39 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:39.645+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:39 volumio volumio[1087]: info: Preparing to unpack .../19-python3-pil_9.4.0-1.1+deb12u1_amd64.deb ... Feb 18 11:15:39 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:39.653+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:39 volumio volumio[1087]: info: Unpacking python3-pil:amd64 (9.4.0-1.1+deb12u1) ... Feb 18 11:15:39 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:39.670+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:40 volumio volumio[1087]: info: Selecting previously unselected package python3-pygame. Feb 18 11:15:40 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:40.377+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:40 volumio volumio[1087]: info: Preparing to unpack .../20-python3-pygame_2.1.2+dfsg-5+b1_amd64.deb ... Feb 18 11:15:40 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:40.385+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:40 volumio volumio[1087]: info: Unpacking python3-pygame (2.1.2+dfsg-5+b1) ... Feb 18 11:15:40 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:40.396+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up libsdl2-image-2.0-0:amd64 (2.6.3+dfsg-1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.402+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up python3-olefile (0.46-3) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.429+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up fonts-freefont-ttf (20120503-10) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.677+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up libfftw3-long3:amd64 (3.3.10-1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.699+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up file (1:5.44-3) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.721+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up bzip2 (1.0.8-5+b1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.754+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up libraqm0:amd64 (0.7.0-4.1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.781+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up libfftw3-quad3:amd64 (3.3.10-1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.815+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up libportmidi0:amd64 (1:217-6.1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.839+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up libimagequant0:amd64 (2.17.0-1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.858+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:41 volumio volumio[1087]: info: Setting up python3-numpy (1:1.24.2-1+deb12u1) ... Feb 18 11:15:41 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:41.880+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:44 volumio volumio[1087]: info: Setting up libfftw3-double3:amd64 (3.3.10-1) ... Feb 18 11:15:44 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:44.696+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:44 volumio volumio[1087]: info: Setting up libsdl2-ttf-2.0-0:amd64 (2.20.1+dfsg-2) ... Feb 18 11:15:44 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:44.718+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:44 volumio volumio[1087]: info: Setting up mailcap (3.70+nmu1) ... Feb 18 11:15:44 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:44.745+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:44 volumio volumio[1087]: info: Setting up libopusfile0:amd64 (0.12-4) ... Feb 18 11:15:44 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:44.830+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:44 volumio volumio[1087]: info: Setting up mime-support (3.66) ... Feb 18 11:15:44 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:44.859+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:44 volumio volumio[1087]: info: Setting up libfftw3-bin (3.3.10-1) ... Feb 18 11:15:44 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:44.880+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:44 volumio volumio[1087]: info: Setting up python3-pil:amd64 (9.4.0-1.1+deb12u1) ... Feb 18 11:15:44 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:44.919+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:45 volumio volumio[1087]: info: Setting up libsdl2-mixer-2.0-0:amd64 (2.6.2+dfsg-2) ... Feb 18 11:15:45 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:45.433+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:45 volumio volumio[1087]: info: Setting up python3-pygame (2.1.2+dfsg-5+b1) ... Feb 18 11:15:45 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:45.466+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:45 volumio volumio[1087]: info: Setting up libfftw3-dev:amd64 (3.3.10-1) ... Feb 18 11:15:45 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:45.746+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:45 volumio volumio[1087]: info: Processing triggers for libc-bin (2.36-9+deb12u13) ... Feb 18 11:15:45 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:45.773+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:45 volumio volumio[1087]: info: Processing triggers for man-db (2.11.2-2) ... Feb 18 11:15:45 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:45.834+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:45 volumio volumio[1087]: info: Processing triggers for fontconfig (2.14.1-4) ... Feb 18 11:15:46 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:46.000+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:46 volumio sudo[3816]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:46 volumio volumio[1087]: info: Linked /data/plugins/user_interface/peppyspectrum/alsa-lib/x86_64/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so Feb 18 11:15:46 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:46.338+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:46 volumio volumio[1087]: info: Linked /data/plugins/user_interface/peppyspectrum/alsa-lib/x86_64/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppyspectrum/alsa-lib/libpeppyalsa.so.0 Feb 18 11:15:46 volumio sudo[4147]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/user_interface/peppyspectrum/startpeppyspectrum.sh Feb 18 11:15:46 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:46.344+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:46 volumio sudo[4147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:46 volumio sudo[4147]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:46 volumio sudo[4149]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Feb 18 11:15:46 volumio sudo[4149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:46 volumio systemd[1]: Reloading. Feb 18 11:15:46 volumio systemd-gpt-auto-generator[4158]: EFI loader partition unknown, exiting. Feb 18 11:15:46 volumio systemd-gpt-auto-generator[4158]: (The boot loader did not set EFI variable LoaderDevicePartUUID.) Feb 18 11:15:46 volumio systemd[1]: /etc/systemd/system/musicservicesshield.service:14: Failed to parse output specifier, ignoring: jouurnal Feb 18 11:15:46 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 18 11:15:46 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Feb 18 11:15:46 volumio sudo[4149]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:46 volumio sudo[3692]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:46 volumio volumio[1087]: Plugin install end detected on script Feb 18 11:15:46 volumio volumio[1087]: info: Install script completed Feb 18 11:15:46 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:46.658+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:46 volumio volumio[1087]: info: Adding reference to registry Feb 18 11:15:46 volumio volumio5-onboarding[1647]: time=2026-02-18T11:15:46.663+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 11:15:46 volumio volumio[1087]: info: Done installing plugin. Feb 18 11:15:46 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 11:15:46 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 11:15:46 volumio volumio[1087]: info: Folder /tmp/plugins removed Feb 18 11:15:46 volumio volumio[1087]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 11:15:46 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 11:15:46 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 11:15:46 volumio volumio[1087]: info: Folder /data/temp removed Feb 18 11:15:48 volumio volumio[1087]: info: Enabling plugin peppyspectrum Feb 18 11:15:48 volumio volumio[1087]: info: Loading plugin "peppyspectrum"... Feb 18 11:15:48 volumio volumio[1087]: info: Preparing to generate the ALSA configuration file Feb 18 11:15:48 volumio volumio[1087]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 18 11:15:48 volumio volumio[1087]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 18 11:15:48 volumio volumio[1087]: info: Reading ALSA contributions from plugins. Feb 18 11:15:48 volumio volumio[1087]: info: Asound.conf file written Feb 18 11:15:48 volumio sudo[4185]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 18 11:15:48 volumio sudo[4185]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio sudo[4185]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:48 volumio volumio[1087]: info: Output device has changed, restarting MPD Feb 18 11:15:48 volumio volumio[1087]: info: Output device has changed, restarting Shairport Sync Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:48 volumio sudo[4191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 18 11:15:48 volumio sudo[4191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio sudo[4191]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:48 volumio sudo[4193]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 18 11:15:48 volumio sudo[4193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio volumio[1087]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 18 11:15:48 volumio volumio[1087]: info: PLUGIN START: peppyspectrum Feb 18 11:15:48 volumio systemd[1]: musicservicesshield.service: Deactivated successfully. Feb 18 11:15:48 volumio systemd[1]: Stopped musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Feb 18 11:15:48 volumio systemd[1]: Stopping musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 18 11:15:48 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 18 11:15:48 volumio volumio[1087]: info: Preparing to generate the ALSA configuration file Feb 18 11:15:48 volumio sudo[4201]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Feb 18 11:15:48 volumio sudo[4201]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio volumio[1087]: info: Done. Feb 18 11:15:48 volumio volumio[1087]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 18 11:15:48 volumio volumio[1087]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 18 11:15:48 volumio volumio[1087]: info: Reading ALSA contributions from plugins. Feb 18 11:15:48 volumio volumio[1087]: info: MPD Permissions set Feb 18 11:15:48 volumio volumio[1087]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Feb 18 11:15:48 volumio sudo[4201]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: snd_dummy loaded Feb 18 11:15:48 volumio volumio[1087]: info: Starting Shairport Sync Feb 18 11:15:48 volumio (udev-worker)[4212]: controlC7: Process '/usr/sbin/alsactl -E HOME=/run/alsa -E XDG_RUNTIME_DIR=/run/alsa/runtime restore 7' failed with exit code 99. Feb 18 11:15:48 volumio volumio[1087]: info: Asound.conf file unchanged, so no further update is needed Feb 18 11:15:48 volumio volumio[1087]: info: Output device has changed, restarting MPD Feb 18 11:15:48 volumio sudo[4218]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 18 11:15:48 volumio sudo[4218]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 18 11:15:48 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 18 11:15:48 volumio systemd[1]: mpd.service: Consumed 1.132s CPU time. Feb 18 11:15:48 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 18 11:15:48 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 18 11:15:48 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 18 11:15:48 volumio volumio[1087]: info: Output device has changed, restarting Shairport Sync Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:48 volumio sudo[4222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 18 11:15:48 volumio sudo[4222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio sudo[4222]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:48 volumio sudo[4224]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 18 11:15:48 volumio sudo[4224]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio volumio[1087]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 18 11:15:48 volumio volumio[1087]: info: MPD Permissions set Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 18 11:15:48 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 18 11:15:48 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 18 11:15:48 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 18 11:15:48 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 18 11:15:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 18 11:15:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:48 volumio systemd[1]: shairport-sync.service: Consumed 3.190s CPU time. Feb 18 11:15:48 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 18 11:15:48 volumio volumio[1087]: info: Starting Shairport Sync Feb 18 11:15:48 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 18 11:15:48 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 18 11:15:48 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 18 11:15:48 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 18 11:15:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:48 volumio sudo[4245]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 18 11:15:48 volumio sudo[4245]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:48 volumio sudo[4218]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:48 volumio volumio[1087]: info: Shairport-Sync Started Feb 18 11:15:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 18 11:15:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 18 11:15:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:48 volumio sudo[4245]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:48 volumio volumio[1087]: info: Shairport-Sync Started Feb 18 11:15:48 volumio sudo[4246]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 18 11:15:48 volumio sudo[4246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:48 volumio sudo[4246]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:49 volumio mpd[4265]: 2026-02-18T11:15:49 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 18 11:15:49 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 18 11:15:49 volumio sudo[4193]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:49 volumio sudo[4224]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:49 volumio volumio[1087]: error: MPD error: The expression evaluated to a falsy value: Feb 18 11:15:49 volumio volumio[1087]: assert.ok(self.idling) Feb 18 11:15:49 volumio volumio[1087]: error: The expression evaluated to a falsy value: Feb 18 11:15:49 volumio volumio[1087]: assert.ok(self.idling) Feb 18 11:15:49 volumio volumio[1087]: error: updateQueue error: null Feb 18 11:15:49 volumio systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Feb 18 11:15:49 volumio bash[4279]: mount: /cpusets: unknown filesystem type 'cpuset'. Feb 18 11:15:49 volumio bash[4279]: dmesg(1) may have more information after failed mount system call. Feb 18 11:15:49 volumio bash[4285]: mount: /cpusets: unknown filesystem type 'cpuset'. Feb 18 11:15:49 volumio bash[4285]: dmesg(1) may have more information after failed mount system call. Feb 18 11:15:49 volumio bash[4291]: mount: /cpusets: unknown filesystem type 'cpuset'. Feb 18 11:15:49 volumio bash[4291]: dmesg(1) may have more information after failed mount system call. Feb 18 11:15:49 volumio bash[4289]: cset: **> mount of cpuset filesystem failed, do you have permission? Feb 18 11:15:49 volumio systemd[1]: Finished musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Feb 18 11:15:53 volumio volumio[1087]: info: Enabling plugin peppyspectrum Feb 18 11:15:53 volumio volumio[1087]: info: Loading plugin "peppyspectrum"... Feb 18 11:15:53 volumio volumio[1087]: info: Preparing to generate the ALSA configuration file Feb 18 11:15:53 volumio volumio[1087]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 18 11:15:53 volumio volumio[1087]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 18 11:15:53 volumio volumio[1087]: info: Reading ALSA contributions from plugins. Feb 18 11:15:53 volumio volumio[1087]: info: Asound.conf file unchanged, so no further update is needed Feb 18 11:15:53 volumio volumio[1087]: info: Output device has changed, restarting MPD Feb 18 11:15:53 volumio volumio[1087]: info: Output device has changed, restarting Shairport Sync Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:53 volumio sudo[4298]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 18 11:15:53 volumio sudo[4298]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:53 volumio sudo[4300]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 18 11:15:53 volumio sudo[4298]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:53 volumio sudo[4300]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:53 volumio volumio[1087]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 18 11:15:53 volumio volumio[1087]: info: PLUGIN START: peppyspectrum Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 18 11:15:53 volumio systemd[1]: musicservicesshield.service: Deactivated successfully. Feb 18 11:15:53 volumio systemd[1]: Stopped musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Feb 18 11:15:53 volumio systemd[1]: Stopping musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Feb 18 11:15:53 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Feb 18 11:15:53 volumio volumio[1087]: info: Preparing to generate the ALSA configuration file Feb 18 11:15:53 volumio sudo[4308]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-aloop index=7 pcm_substreams=1 Feb 18 11:15:53 volumio sudo[4308]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:53 volumio volumio[1087]: info: Done. Feb 18 11:15:53 volumio volumio[1087]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Feb 18 11:15:53 volumio volumio[1087]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Feb 18 11:15:53 volumio volumio[1087]: info: Reading ALSA contributions from plugins. Feb 18 11:15:53 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 18 11:15:53 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 18 11:15:53 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 18 11:15:53 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 18 11:15:53 volumio volumio[1087]: info: MPD Permissions set Feb 18 11:15:53 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 18 11:15:53 volumio volumio[1087]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 15 Feb 18 11:15:53 volumio sudo[4308]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 18 11:15:53 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 18 11:15:53 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: snd_dummy loaded Feb 18 11:15:53 volumio volumio[1087]: info: Starting Shairport Sync Feb 18 11:15:53 volumio volumio[1087]: info: Asound.conf file unchanged, so no further update is needed Feb 18 11:15:53 volumio volumio[1087]: info: Output device has changed, restarting MPD Feb 18 11:15:53 volumio sudo[4322]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 18 11:15:53 volumio sudo[4322]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:53 volumio volumio[1087]: info: Output device has changed, restarting Shairport Sync Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:53 volumio sudo[4327]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 18 11:15:53 volumio sudo[4325]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 18 11:15:53 volumio sudo[4325]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:53 volumio sudo[4327]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:53 volumio sudo[4325]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:53 volumio volumio[1087]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 18 11:15:53 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 18 11:15:53 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 18 11:15:53 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:53 volumio systemd[1]: shairport-sync.service: Consumed 1.567s CPU time. Feb 18 11:15:53 volumio volumio[1087]: info: MPD Permissions set Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 18 11:15:53 volumio sudo[4322]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:53 volumio sudo[4319]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 18 11:15:53 volumio sudo[4319]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:53 volumio sudo[4319]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:53 volumio systemd[1]: mpd.service: Deactivated successfully. Feb 18 11:15:53 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Feb 18 11:15:53 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 18 11:15:53 volumio volumio[1087]: info: Shairport-Sync Started Feb 18 11:15:53 volumio systemd[1]: mpd.socket: Deactivated successfully. Feb 18 11:15:53 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Feb 18 11:15:53 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Feb 18 11:15:53 volumio volumio[1087]: info: Starting Shairport Sync Feb 18 11:15:53 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Feb 18 11:15:53 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Feb 18 11:15:53 volumio sudo[4362]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 18 11:15:53 volumio sudo[4362]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Feb 18 11:15:53 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Feb 18 11:15:53 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Feb 18 11:15:53 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:54 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Feb 18 11:15:54 volumio sudo[4362]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:54 volumio volumio[1087]: info: Shairport-Sync Started Feb 18 11:15:54 volumio sudo[4361]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 18 11:15:54 volumio sudo[4361]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 11:15:54 volumio sudo[4361]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:54 volumio mpd[4380]: 2026-02-18T11:15:54 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 18 11:15:54 volumio systemd[1]: Started mpd.service - Music Player Daemon. Feb 18 11:15:54 volumio sudo[4327]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:54 volumio sudo[4300]: pam_unix(sudo:session): session closed for user root Feb 18 11:15:54 volumio volumio[1087]: error: MPD error: The expression evaluated to a falsy value: Feb 18 11:15:54 volumio volumio[1087]: assert.ok(self.idling) Feb 18 11:15:54 volumio volumio[1087]: error: The expression evaluated to a falsy value: Feb 18 11:15:54 volumio volumio[1087]: assert.ok(self.idling) Feb 18 11:15:54 volumio volumio[1087]: error: updateQueue error: null Feb 18 11:15:54 volumio systemd[1]: Starting musicservicesshield.service - Shield Volumio Music Services in the User CPU Set... Feb 18 11:15:54 volumio bash[4394]: mount: /cpusets: unknown filesystem type 'cpuset'. Feb 18 11:15:54 volumio bash[4394]: dmesg(1) may have more information after failed mount system call. Feb 18 11:15:54 volumio bash[4400]: mount: /cpusets: unknown filesystem type 'cpuset'. Feb 18 11:15:54 volumio bash[4400]: dmesg(1) may have more information after failed mount system call. Feb 18 11:15:54 volumio bash[4406]: mount: /cpusets: unknown filesystem type 'cpuset'. Feb 18 11:15:54 volumio bash[4406]: dmesg(1) may have more information after failed mount system call. Feb 18 11:15:54 volumio bash[4404]: cset: **> mount of cpuset filesystem failed, do you have permission? Feb 18 11:15:54 volumio systemd[1]: Finished musicservicesshield.service - Shield Volumio Music Services in the User CPU Set. Feb 18 11:16:03 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 11:16:09 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 11:16:20 volumio volumio[1087]: info: CALLMETHOD: user_interface peppyspectrum savepeppy [object Object] Feb 18 11:16:20 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , savepeppy Feb 18 11:16:20 volumio volumio[1087]: aaaaaaaaaaa 480,320 Feb 18 11:16:20 volumio volumio[1087]: info: PeppySpectrum ---480320 Feb 18 11:16:20 volumio volumio[1087]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Feb 18 11:16:20 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 11:16:20 volumio volumio[1087]: info: CoreCommandRouter::Close All Modals sent Feb 18 11:16:33 volumio volumio[1087]: info: CALLMETHOD: user_interface peppyspectrum updatelist Feb 18 11:16:33 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , updatelist Feb 18 11:16:33 volumio volumio[1087]: info: PeppySpectrum --- wget 'https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt' Feb 18 11:16:33 volumio volumio[1087]: --2026-02-18 11:16:33-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/spectrumslist.txt Feb 18 11:16:33 volumio volumio[1087]: Resolving github.com (github.com)... 140.82.121.3 Feb 18 11:16:33 volumio volumio[1087]: Connecting to github.com (github.com)|140.82.121.3|:443... connected. Feb 18 11:16:33 volumio volumio[1087]: HTTP request sent, awaiting response... 302 Found Feb 18 11:16:33 volumio volumio[1087]: Location: https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt [following] Feb 18 11:16:33 volumio volumio[1087]: --2026-02-18 11:16:33-- https://raw.githubusercontent.com/balbuze/Spectrum-peppyspectrum/main/spectrumslist.txt Feb 18 11:16:33 volumio volumio[1087]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.108.133, 185.199.110.133, 185.199.109.133, ... Feb 18 11:16:33 volumio volumio[1087]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.108.133|:443... connected. Feb 18 11:16:33 volumio volumio[1087]: HTTP request sent, awaiting response... 200 OK Feb 18 11:16:33 volumio volumio[1087]: Length: 471 [text/plain] Feb 18 11:16:33 volumio volumio[1087]: Saving to: ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ Feb 18 11:16:33 volumio volumio[1087]: 0K 100% 35.9M=0s Feb 18 11:16:33 volumio volumio[1087]: 2026-02-18 11:16:33 (35.9 MB/s) - ‘/data/plugins/user_interface/peppyspectrum/spectrumslist.txt’ saved [471/471] Feb 18 11:16:34 volumio volumio[1087]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 18 11:16:34 volumio volumio[1087]: info: CoreCommandRouter::Close All Modals sent Feb 18 11:16:34 volumio volumio[1087]: info: CALLMETHOD: user_interface peppyspectrum dlspectrum [object Object] Feb 18 11:16:34 volumio volumio[1087]: info: CoreCommandRouter::executeOnPlugin: peppyspectrum , dlspectrum Feb 18 11:16:35 volumio volumio[1087]: --2026-02-18 11:16:34-- https://github.com/balbuze/Spectrum-peppyspectrum/raw/main/Zipped-folders/Choose Feb 18 11:16:35 volumio volumio[1087]: Resolving github.com (github.com)... 140.82.121.4 Feb 18 11:16:35 volumio volumio[1087]: Connecting to github.com (github.com)|140.82.121.4|:443... connected. Feb 18 11:16:35 volumio volumio[1087]: HTTP request sent, awaiting response... 404 Not Found Feb 18 11:16:35 volumio volumio[1087]: 2026-02-18 11:16:34 ERROR 404: Not Found. Feb 18 11:16:35 volumio volumio[1087]: --2026-02-18 11:16:34-- http://a/ Feb 18 11:16:35 volumio volumio[1087]: Resolving a (a)... failed: Device or resource busy. Feb 18 11:16:35 volumio volumio[1087]: wget: unable to resolve host address ‘a’ Feb 18 11:16:35 volumio volumio[1087]: --2026-02-18 11:16:34-- http://packet.zip/ Feb 18 11:16:35 volumio volumio[1087]: Resolving packet.zip (packet.zip)... 162.255.119.167 Feb 18 11:16:35 volumio volumio[1087]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Feb 18 11:16:35 volumio volumio[1087]: HTTP request sent, awaiting response... 302 Found Feb 18 11:16:35 volumio volumio[1087]: Location: http://www.packet.zip/ [following] Feb 18 11:16:35 volumio volumio[1087]: --2026-02-18 11:16:35-- http://www.packet.zip/ Feb 18 11:16:35 volumio volumio[1087]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Feb 18 11:16:35 volumio volumio[1087]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Feb 18 11:16:35 volumio volumio[1087]: HTTP request sent, awaiting response... 403 Forbidden Feb 18 11:16:35 volumio volumio[1087]: 2026-02-18 11:16:35 ERROR 403: Forbidden. Feb 18 11:16:35 volumio volumio[1087]: error: PeppySpectrum --- An error occurs while downloading or installing Spectrums Feb 18 11:16:35 volumio volumio[1087]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 18 11:16:35 volumio volumio[1087]: /bin/rm: cannot remove 'a': No such file or directory Feb 18 11:16:35 volumio volumio[1087]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 18 11:16:35 volumio volumio[1087]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 11:16:35 volumio volumio[1087]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Feb 18 11:16:35 volumio volumio[1087]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Feb 18 11:16:35 volumio volumio[1087]: /bin/rm: cannot remove 'a': No such file or directory Feb 18 11:16:35 volumio volumio[1087]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Feb 18 11:16:35 volumio volumio[1087]: at checkExecSyncError (node:child_process:887:11) Feb 18 11:16:35 volumio volumio[1087]: at execSync (node:child_process:959:15) Feb 18 11:16:35 volumio volumio[1087]: at /data/plugins/user_interface/peppyspectrum/index.js:770:19 Feb 18 11:16:35 volumio volumio[1087]: at new Promise () Feb 18 11:16:35 volumio volumio[1087]: at peppyspectrum.dlspectrum (/data/plugins/user_interface/peppyspectrum/index.js:745:12) Feb 18 11:16:35 volumio volumio[1087]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Feb 18 11:16:35 volumio volumio[1087]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Feb 18 11:16:35 volumio volumio[1087]: at Socket.emit (node:events:514:28) Feb 18 11:16:35 volumio volumio[1087]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 18 11:16:35 volumio volumio[1087]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Feb 18 11:16:35 volumio volumio[1087]: status: 1, Feb 18 11:16:35 volumio volumio[1087]: signal: null, Feb 18 11:16:35 volumio volumio[1087]: output: [ Feb 18 11:16:35 volumio volumio[1087]: null, Feb 18 11:16:35 volumio volumio[1087]: , Feb 18 11:16:35 volumio volumio[1087]: Feb 18 11:16:35 volumio volumio[1087]: ], Feb 18 11:16:35 volumio volumio[1087]: pid: 4520, Feb 18 11:16:35 volumio volumio[1087]: stdout: , Feb 18 11:16:35 volumio volumio[1087]: stderr: Feb 18 11:16:35 volumio volumio[1087]: } Feb 18 11:16:35 volumio volumio[1087]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 11:16:35 volumio sudo[4536]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-18 11:15' Feb 18 11:16:35 volumio sudo[4536]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"