Dec 23 17:59:00 volumio volumio[1220]: info: Checking if install.sh is present Dec 23 17:59:00 volumio volumio[1220]: info: Executing install.sh Dec 23 17:59:00 volumio sudo[5243]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/peppymeterbasic/install.sh Dec 23 17:59:00 volumio sudo[5243]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:00 volumio volumio[1220]: info: Installing peppyalsa plugin dependencies Dec 23 17:59:00 volumio sudo[5247]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get update Dec 23 17:59:00 volumio sudo[5247]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:00 volumio volumio[1220]: info: Get:1 http://raspbian.raspberrypi.com/raspbian bookworm InRelease [15.0 kB] Dec 23 17:59:00 volumio volumio[1220]: info: Hit:2 http://archive.raspberrypi.com/debian bookworm InRelease Dec 23 17:59:00 volumio volumio[1220]: info: Hit:3 https://deb.nodesource.com/node_20.x nodistro InRelease Dec 23 17:59:01 volumio volumio[1220]: info: Fetched 15.0 kB in 1s (17.8 kB/s) Dec 23 17:59:04 volumio volumio[1220]: info: Reading package lists... Dec 23 17:59:04 volumio sudo[5247]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:04 volumio volumio[1220]: info: cloning peppymeter repo Dec 23 17:59:07 volumio sudo[5434]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chown -R volumio /data/plugins/user_interface/peppymeterbasic /data/INTERNAL/PeppyMeterBasic/Templates Dec 23 17:59:07 volumio sudo[5434]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:07 volumio sudo[5434]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:07 volumio sudo[5436]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chgrp -R volumio /data/plugins/user_interface/peppymeterbasic /data/INTERNAL/PeppyMeterBasic/Templates Dec 23 17:59:07 volumio sudo[5436]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:07 volumio sudo[5436]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:07 volumio volumio[1220]: info: installing apt packages Dec 23 17:59:07 volumio sudo[5438]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get -yf install python3-pygame python3-pip python3-dev libjpeg-dev zlib1g-dev libfftw3-dev Dec 23 17:59:07 volumio sudo[5438]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:07 volumio volumio[1220]: info: Reading package lists... Dec 23 17:59:07 volumio volumio[1220]: info: Building dependency tree... Dec 23 17:59:07 volumio volumio[1220]: info: Reading state information... Dec 23 17:59:08 volumio volumio[1220]: info: python3-pygame is already the newest version (2.1.2+dfsg-5). Dec 23 17:59:08 volumio volumio[1220]: info: python3-pip is already the newest version (23.0.1+dfsg-1+rpt1). Dec 23 17:59:08 volumio volumio[1220]: info: libfftw3-dev is already the newest version (3.3.10-1). Dec 23 17:59:08 volumio volumio[1220]: info: The following additional packages will be installed: Dec 23 17:59:08 volumio volumio[1220]: info: libabsl20220623 libavif15 libc-dev-bin libc-devtools libc6-dev libcrypt-dev Dec 23 17:59:08 volumio volumio[1220]: info: libexpat1-dev libgav1-1 libgd3 libjpeg62-turbo-dev libnsl-dev libpython3-dev Dec 23 17:59:08 volumio volumio[1220]: info: libpython3.11-dev libtirpc-dev libyuv0 linux-libc-dev manpages manpages-dev Dec 23 17:59:08 volumio volumio[1220]: info: python3.11-dev rpcsvc-proto Dec 23 17:59:08 volumio volumio[1220]: info: Suggested packages: Dec 23 17:59:08 volumio volumio[1220]: info: glibc-doc libgd-tools Dec 23 17:59:08 volumio volumio[1220]: info: The following NEW packages will be installed: Dec 23 17:59:08 volumio volumio[1220]: info: libabsl20220623 libavif15 libc-dev-bin libc-devtools libc6-dev libcrypt-dev Dec 23 17:59:08 volumio volumio[1220]: info: libexpat1-dev libgav1-1 libgd3 libjpeg-dev libjpeg62-turbo-dev libnsl-dev Dec 23 17:59:08 volumio volumio[1220]: info: libpython3-dev libpython3.11-dev libtirpc-dev libyuv0 linux-libc-dev Dec 23 17:59:08 volumio volumio[1220]: info: manpages manpages-dev python3-dev python3.11-dev rpcsvc-proto zlib1g-dev Dec 23 17:59:09 volumio volumio[1220]: info: 0 upgraded, 23 newly installed, 0 to remove and 18 not upgraded. Dec 23 17:59:09 volumio volumio[1220]: info: Need to get 14.3 MB of archives. Dec 23 17:59:09 volumio volumio[1220]: info: After this operation, 46.6 MB of additional disk space will be used. Dec 23 17:59:09 volumio volumio[1220]: info: Get:1 http://archive.raspberrypi.com/debian bookworm/main armhf libc-dev-bin armhf 2.36-9+rpt2+deb12u13 [49.3 kB] Dec 23 17:59:09 volumio volumio[1220]: info: Get:3 http://archive.raspberrypi.com/debian bookworm/main armhf libc-devtools armhf 2.36-9+rpt2+deb12u13 [62.7 kB] Dec 23 17:59:09 volumio volumio[1220]: info: Get:4 http://archive.raspberrypi.com/debian bookworm/main armhf linux-libc-dev all 1:6.12.47-1+rpt1~bookworm [2315 kB] Dec 23 17:59:09 volumio volumio[1220]: info: Get:2 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf manpages all 6.03-2 [1332 kB] Dec 23 17:59:11 volumio volumio[1220]: info: Get:8 http://archive.raspberrypi.com/debian bookworm/main armhf libc6-dev armhf 2.36-9+rpt2+deb12u13 [1831 kB] Dec 23 17:59:11 volumio volumio[1220]: info: Get:9 http://archive.raspberrypi.com/debian bookworm/main armhf zlib1g-dev armhf 1:1.2.13.dfsg-1+rpt1 [902 kB] Dec 23 17:59:12 volumio volumio[1220]: info: Get:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libabsl20220623 armhf 20220623.1-1+rpi1+deb12u2 [356 kB] Dec 23 17:59:12 volumio volumio[1220]: info: Get:6 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libgav1-1 armhf 0.18.0-1+rpi1+b1 [285 kB] Dec 23 17:59:12 volumio volumio[1220]: info: Get:7 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libyuv0 armhf 0.0~git20230123.b2528b0-1 [82.7 kB] Dec 23 17:59:12 volumio volumio[1220]: info: Get:10 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libavif15 armhf 0.11.1-1+deb12u1 [84.2 kB] Dec 23 17:59:12 volumio volumio[1220]: info: Get:11 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf libgd3 armhf 2.3.3-9 [103 kB] Dec 23 17:59:12 volumio volumio[1220]: info: Get:12 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf libcrypt-dev armhf 1:4.4.33-2 [121 kB] Dec 23 17:59:13 volumio volumio[1220]: info: Get:13 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libtirpc-dev armhf 1.3.3+ds-1 [174 kB] Dec 23 17:59:13 volumio volumio[1220]: info: Get:14 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf libnsl-dev armhf 1.3.0-2 [58.9 kB] Dec 23 17:59:13 volumio volumio[1220]: info: Get:15 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf rpcsvc-proto armhf 1.4.3-1 [55.1 kB] Dec 23 17:59:13 volumio volumio[1220]: info: Get:16 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libexpat1-dev armhf 2.5.0-1+deb12u2 [132 kB] Dec 23 17:59:14 volumio volumio[1220]: info: Get:17 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf libjpeg62-turbo-dev armhf 1:2.1.5-2 [258 kB] Dec 23 17:59:14 volumio volumio[1220]: info: Get:18 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf libjpeg-dev armhf 1:2.1.5-2 [71.8 kB] Dec 23 17:59:14 volumio volumio[1220]: info: Get:19 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libpython3.11-dev armhf 3.11.2-6+deb12u6 [3372 kB] Dec 23 17:59:15 volumio volumio[1220]: info: Get:20 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf libpython3-dev armhf 3.11.2-1 [9248 B] Dec 23 17:59:15 volumio volumio[1220]: info: Get:21 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf manpages-dev all 6.03-2 [2030 kB] Dec 23 17:59:16 volumio volumio[1220]: info: Get:22 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3.11-dev armhf 3.11.2-6+deb12u6 [618 kB] Dec 23 17:59:16 volumio volumio[1220]: info: Get:23 http://ftp.arnes.si/mirrors/raspbian/raspbian bookworm/main armhf python3-dev armhf 3.11.2-1 [26.2 kB] Dec 23 17:59:17 volumio volumio[1220]: info: Fetched 14.3 MB in 8s (1791 kB/s) Dec 23 17:59:18 volumio volumio[1220]: info: Selecting previously unselected package manpages. Dec 23 17:59:19 volumio volumio[1220]: [620B blob data] Dec 23 17:59:19 volumio volumio[1220]: info: Preparing to unpack .../00-manpages_6.03-2_all.deb ... Dec 23 17:59:19 volumio volumio[1220]: info: Unpacking manpages (6.03-2) ... Dec 23 17:59:20 volumio volumio[1220]: info: Selecting previously unselected package libabsl20220623:armhf. Dec 23 17:59:20 volumio volumio[1220]: info: Preparing to unpack .../01-libabsl20220623_20220623.1-1+rpi1+deb12u2_armhf.deb ... Dec 23 17:59:20 volumio volumio[1220]: info: Unpacking libabsl20220623:armhf (20220623.1-1+rpi1+deb12u2) ... Dec 23 17:59:20 volumio volumio[1220]: info: Selecting previously unselected package libgav1-1:armhf. Dec 23 17:59:20 volumio volumio[1220]: info: Preparing to unpack .../02-libgav1-1_0.18.0-1+rpi1+b1_armhf.deb ... Dec 23 17:59:20 volumio volumio[1220]: info: Unpacking libgav1-1:armhf (0.18.0-1+rpi1+b1) ... Dec 23 17:59:21 volumio volumio[1220]: info: Selecting previously unselected package libyuv0:armhf. Dec 23 17:59:21 volumio volumio[1220]: info: Preparing to unpack .../03-libyuv0_0.0~git20230123.b2528b0-1_armhf.deb ... Dec 23 17:59:21 volumio volumio[1220]: info: Unpacking libyuv0:armhf (0.0~git20230123.b2528b0-1) ... Dec 23 17:59:21 volumio volumio[1220]: info: Selecting previously unselected package libavif15:armhf. Dec 23 17:59:21 volumio volumio[1220]: info: Preparing to unpack .../04-libavif15_0.11.1-1+deb12u1_armhf.deb ... Dec 23 17:59:21 volumio volumio[1220]: info: Unpacking libavif15:armhf (0.11.1-1+deb12u1) ... Dec 23 17:59:21 volumio volumio[1220]: info: Selecting previously unselected package libc-dev-bin. Dec 23 17:59:21 volumio volumio[1220]: info: Preparing to unpack .../05-libc-dev-bin_2.36-9+rpt2+deb12u13_armhf.deb ... Dec 23 17:59:21 volumio volumio[1220]: info: Unpacking libc-dev-bin (2.36-9+rpt2+deb12u13) ... Dec 23 17:59:21 volumio volumio[1220]: info: Selecting previously unselected package libgd3:armhf. Dec 23 17:59:21 volumio volumio[1220]: info: Preparing to unpack .../06-libgd3_2.3.3-9_armhf.deb ... Dec 23 17:59:21 volumio volumio[1220]: info: Unpacking libgd3:armhf (2.3.3-9) ... Dec 23 17:59:21 volumio volumio[1220]: info: Selecting previously unselected package libc-devtools. Dec 23 17:59:21 volumio volumio[1220]: info: Preparing to unpack .../07-libc-devtools_2.36-9+rpt2+deb12u13_armhf.deb ... Dec 23 17:59:21 volumio volumio[1220]: info: Unpacking libc-devtools (2.36-9+rpt2+deb12u13) ... Dec 23 17:59:21 volumio volumio[1220]: info: Selecting previously unselected package linux-libc-dev. Dec 23 17:59:21 volumio volumio[1220]: info: Preparing to unpack .../08-linux-libc-dev_1%3a6.12.47-1+rpt1~bookworm_all.deb ... Dec 23 17:59:21 volumio volumio[1220]: info: Unpacking linux-libc-dev (1:6.12.47-1+rpt1~bookworm) ... Dec 23 17:59:24 volumio volumio[1220]: info: Selecting previously unselected package libcrypt-dev:armhf. Dec 23 17:59:25 volumio volumio[1220]: info: Preparing to unpack .../09-libcrypt-dev_1%3a4.4.33-2_armhf.deb ... Dec 23 17:59:25 volumio volumio[1220]: info: Unpacking libcrypt-dev:armhf (1:4.4.33-2) ... Dec 23 17:59:25 volumio volumio[1220]: info: Selecting previously unselected package libtirpc-dev:armhf. Dec 23 17:59:25 volumio volumio[1220]: info: Preparing to unpack .../10-libtirpc-dev_1.3.3+ds-1_armhf.deb ... Dec 23 17:59:25 volumio volumio[1220]: info: Unpacking libtirpc-dev:armhf (1.3.3+ds-1) ... Dec 23 17:59:25 volumio volumio[1220]: info: Selecting previously unselected package libnsl-dev:armhf. Dec 23 17:59:25 volumio volumio[1220]: info: Preparing to unpack .../11-libnsl-dev_1.3.0-2_armhf.deb ... Dec 23 17:59:25 volumio volumio[1220]: info: Unpacking libnsl-dev:armhf (1.3.0-2) ... Dec 23 17:59:25 volumio volumio[1220]: info: Selecting previously unselected package rpcsvc-proto. Dec 23 17:59:25 volumio volumio[1220]: info: Preparing to unpack .../12-rpcsvc-proto_1.4.3-1_armhf.deb ... Dec 23 17:59:25 volumio volumio[1220]: info: Unpacking rpcsvc-proto (1.4.3-1) ... Dec 23 17:59:25 volumio volumio[1220]: info: Selecting previously unselected package libc6-dev:armhf. Dec 23 17:59:25 volumio volumio[1220]: info: Preparing to unpack .../13-libc6-dev_2.36-9+rpt2+deb12u13_armhf.deb ... Dec 23 17:59:25 volumio volumio[1220]: info: Unpacking libc6-dev:armhf (2.36-9+rpt2+deb12u13) ... Dec 23 17:59:27 volumio volumio[1220]: info: Selecting previously unselected package libexpat1-dev:armhf. Dec 23 17:59:27 volumio volumio[1220]: info: Preparing to unpack .../14-libexpat1-dev_2.5.0-1+deb12u2_armhf.deb ... Dec 23 17:59:27 volumio volumio[1220]: info: Unpacking libexpat1-dev:armhf (2.5.0-1+deb12u2) ... Dec 23 17:59:27 volumio volumio[1220]: info: Selecting previously unselected package libjpeg62-turbo-dev:armhf. Dec 23 17:59:27 volumio volumio[1220]: info: Preparing to unpack .../15-libjpeg62-turbo-dev_1%3a2.1.5-2_armhf.deb ... Dec 23 17:59:27 volumio volumio[1220]: info: Unpacking libjpeg62-turbo-dev:armhf (1:2.1.5-2) ... Dec 23 17:59:27 volumio volumio[1220]: info: Selecting previously unselected package libjpeg-dev:armhf. Dec 23 17:59:27 volumio volumio[1220]: info: Preparing to unpack .../16-libjpeg-dev_1%3a2.1.5-2_armhf.deb ... Dec 23 17:59:27 volumio volumio[1220]: info: Unpacking libjpeg-dev:armhf (1:2.1.5-2) ... Dec 23 17:59:28 volumio volumio[1220]: info: Selecting previously unselected package zlib1g-dev:armhf. Dec 23 17:59:28 volumio volumio[1220]: info: Preparing to unpack .../17-zlib1g-dev_1%3a1.2.13.dfsg-1+rpt1_armhf.deb ... Dec 23 17:59:28 volumio volumio[1220]: info: Unpacking zlib1g-dev:armhf (1:1.2.13.dfsg-1+rpt1) ... Dec 23 17:59:28 volumio volumio[1220]: info: Selecting previously unselected package libpython3.11-dev:armhf. Dec 23 17:59:28 volumio volumio[1220]: info: Preparing to unpack .../18-libpython3.11-dev_3.11.2-6+deb12u6_armhf.deb ... Dec 23 17:59:28 volumio volumio[1220]: info: Unpacking libpython3.11-dev:armhf (3.11.2-6+deb12u6) ... Dec 23 17:59:29 volumio volumio[1220]: info: Selecting previously unselected package libpython3-dev:armhf. Dec 23 17:59:29 volumio volumio[1220]: info: Preparing to unpack .../19-libpython3-dev_3.11.2-1_armhf.deb ... Dec 23 17:59:29 volumio volumio[1220]: info: Unpacking libpython3-dev:armhf (3.11.2-1) ... Dec 23 17:59:29 volumio volumio[1220]: info: Selecting previously unselected package manpages-dev. Dec 23 17:59:29 volumio volumio[1220]: info: Preparing to unpack .../20-manpages-dev_6.03-2_all.deb ... Dec 23 17:59:29 volumio volumio[1220]: info: Unpacking manpages-dev (6.03-2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Selecting previously unselected package python3.11-dev. Dec 23 17:59:33 volumio volumio[1220]: info: Preparing to unpack .../21-python3.11-dev_3.11.2-6+deb12u6_armhf.deb ... Dec 23 17:59:33 volumio volumio[1220]: info: Unpacking python3.11-dev (3.11.2-6+deb12u6) ... Dec 23 17:59:33 volumio volumio[1220]: info: Selecting previously unselected package python3-dev. Dec 23 17:59:33 volumio volumio[1220]: info: Preparing to unpack .../22-python3-dev_3.11.2-1_armhf.deb ... Dec 23 17:59:33 volumio volumio[1220]: info: Unpacking python3-dev (3.11.2-1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libabsl20220623:armhf (20220623.1-1+rpi1+deb12u2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up manpages (6.03-2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up linux-libc-dev (1:6.12.47-1+rpt1~bookworm) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libtirpc-dev:armhf (1.3.3+ds-1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up rpcsvc-proto (1.4.3-1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libgav1-1:armhf (0.18.0-1+rpi1+b1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libnsl-dev:armhf (1.3.0-2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libcrypt-dev:armhf (1:4.4.33-2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libc-dev-bin (2.36-9+rpt2+deb12u13) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libyuv0:armhf (0.0~git20230123.b2528b0-1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up manpages-dev (6.03-2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libavif15:armhf (0.11.1-1+deb12u1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libgd3:armhf (2.3.3-9) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libc6-dev:armhf (2.36-9+rpt2+deb12u13) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libc-devtools (2.36-9+rpt2+deb12u13) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libexpat1-dev:armhf (2.5.0-1+deb12u2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libjpeg62-turbo-dev:armhf (1:2.1.5-2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up zlib1g-dev:armhf (1:1.2.13.dfsg-1+rpt1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libjpeg-dev:armhf (1:2.1.5-2) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libpython3.11-dev:armhf (3.11.2-6+deb12u6) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up libpython3-dev:armhf (3.11.2-1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up python3.11-dev (3.11.2-6+deb12u6) ... Dec 23 17:59:33 volumio volumio[1220]: info: Setting up python3-dev (3.11.2-1) ... Dec 23 17:59:33 volumio volumio[1220]: info: Processing triggers for man-db (2.11.2-2) ... Dec 23 17:59:35 volumio volumio[1220]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Dec 23 17:59:36 volumio sudo[5438]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:36 volumio sudo[5790]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Dec 23 17:59:36 volumio sudo[5790]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:36 volumio systemd[1]: Reloading. Dec 23 17:59:36 volumio sudo[5790]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:36 volumio volumio[1220]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so Dec 23 17:59:36 volumio volumio[1220]: info: Linked /data/plugins/user_interface/peppymeterbasic/alsa-lib/armhf/libpeppyalsa.so.0.0.0 to /data/plugins/user_interface/peppymeterbasic/alsa-lib/libpeppyalsa.so.0 Dec 23 17:59:38 volumio sudo[5832]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/user_interface/peppymeterbasic/startpeppymeterbasic.sh Dec 23 17:59:38 volumio sudo[5832]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:38 volumio sudo[5832]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:38 volumio sudo[5243]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:38 volumio volumio[1220]: Plugin install end detected on script Dec 23 17:59:38 volumio volumio[1220]: info: Install script completed Dec 23 17:59:38 volumio volumio[1220]: info: Adding reference to registry Dec 23 17:59:38 volumio volumio[1220]: info: Done installing plugin. Dec 23 17:59:38 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 23 17:59:38 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 23 17:59:38 volumio volumio[1220]: info: Folder /tmp/plugins removed Dec 23 17:59:38 volumio volumio[1220]: info: Folder /tmp/downloaded_plugin.zip removed Dec 23 17:59:38 volumio volumio[1220]: info: Folder /data/temp removed Dec 23 17:59:44 volumio volumio[1220]: info: Enabling plugin peppymeterbasic Dec 23 17:59:44 volumio volumio[1220]: info: Loading plugin "peppymeterbasic"... Dec 23 17:59:44 volumio volumio[1220]: info: Preparing to generate the ALSA configuration file Dec 23 17:59:44 volumio volumio[1220]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 23 17:59:44 volumio volumio[1220]: info: Reading ALSA contributions from plugins. Dec 23 17:59:44 volumio volumio[1220]: info: Asound.conf file written Dec 23 17:59:44 volumio sudo[5837]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 23 17:59:44 volumio sudo[5837]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio sudo[5837]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:44 volumio volumio[1220]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Dec 23 17:59:44 volumio volumio[1220]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Dec 23 17:59:44 volumio volumio[1220]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:7 use case configuration -2 Dec 23 17:59:44 volumio volumio[1220]: info: Output device has changed, restarting MPD Dec 23 17:59:44 volumio volumio[1220]: info: Output device has changed, restarting Shairport Sync Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:44 volumio sudo[5845]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 23 17:59:44 volumio sudo[5845]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio sudo[5845]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:44 volumio sudo[5847]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 17:59:44 volumio sudo[5847]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio volumio[1220]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 23 17:59:44 volumio volumio[1220]: info: PLUGIN START: peppymeterbasic Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 23 17:59:44 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 23 17:59:44 volumio volumio[1220]: info: Preparing to generate the ALSA configuration file Dec 23 17:59:44 volumio sudo[5857]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Dec 23 17:59:44 volumio sudo[5857]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio sudo[5857]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:44 volumio volumio[1220]: info: Done. Dec 23 17:59:44 volumio volumio[1220]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 23 17:59:44 volumio volumio[1220]: info: Reading ALSA contributions from plugins. Dec 23 17:59:44 volumio volumio[1220]: info: snd_dummy loaded Dec 23 17:59:44 volumio volumio[1220]: info: MPD Permissions set Dec 23 17:59:44 volumio volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: Starting Shairport Sync Dec 23 17:59:44 volumio sudo[5865]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 23 17:59:44 volumio sudo[5865]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio volumio[1220]: info: Asound.conf file unchanged, so no further update is needed Dec 23 17:59:44 volumio volumio[1220]: info: Output device has changed, restarting MPD Dec 23 17:59:44 volumio volumio[1220]: info: Output device has changed, restarting Shairport Sync Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:44 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 23 17:59:44 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 23 17:59:44 volumio sudo[5868]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 23 17:59:44 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:44 volumio systemd[1]: shairport-sync.service: Consumed 1.901s CPU time. Dec 23 17:59:44 volumio sudo[5868]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio volumio[1220]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 23 17:59:44 volumio sudo[5868]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:44 volumio sudo[5870]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 17:59:44 volumio sudo[5870]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio volumio[1220]: info: MPD Permissions set Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:44 volumio volumio[1220]: info: Starting Shairport Sync Dec 23 17:59:44 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:44 volumio sudo[5887]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 23 17:59:44 volumio sudo[5887]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:44 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 23 17:59:44 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 23 17:59:44 volumio systemd[1]: mpd.service: Consumed 2.476s CPU time. Dec 23 17:59:44 volumio sudo[5865]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:44 volumio volumio[1220]: info: Shairport-Sync Started Dec 23 17:59:44 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 23 17:59:44 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 23 17:59:44 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 23 17:59:44 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 23 17:59:44 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 23 17:59:44 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 23 17:59:44 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 23 17:59:44 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:44 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:44 volumio sudo[5887]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:44 volumio volumio[1220]: info: Shairport-Sync Started Dec 23 17:59:44 volumio sudo[5903]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 23 17:59:44 volumio sudo[5903]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:44 volumio sudo[5903]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:46 volumio mpd[5920]: 2025-12-23T17:59:46 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 23 17:59:47 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 23 17:59:47 volumio sudo[5870]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:47 volumio sudo[5847]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:47 volumio volumio[1220]: error: MPD error: The expression evaluated to a falsy value: Dec 23 17:59:47 volumio volumio[1220]: assert.ok(self.idling) Dec 23 17:59:47 volumio volumio[1220]: error: The expression evaluated to a falsy value: Dec 23 17:59:47 volumio volumio[1220]: assert.ok(self.idling) Dec 23 17:59:47 volumio volumio[1220]: error: updateQueue error: null Dec 23 17:59:48 volumio volumio[1220]: info: Enabling plugin peppymeterbasic Dec 23 17:59:48 volumio volumio[1220]: info: Loading plugin "peppymeterbasic"... Dec 23 17:59:48 volumio volumio[1220]: info: Preparing to generate the ALSA configuration file Dec 23 17:59:48 volumio volumio[1220]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 23 17:59:48 volumio volumio[1220]: info: Reading ALSA contributions from plugins. Dec 23 17:59:48 volumio volumio[1220]: info: Asound.conf file unchanged, so no further update is needed Dec 23 17:59:48 volumio volumio[1220]: info: Output device has changed, restarting MPD Dec 23 17:59:48 volumio volumio[1220]: info: Output device has changed, restarting Shairport Sync Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:48 volumio sudo[5938]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 23 17:59:48 volumio sudo[5938]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:48 volumio sudo[5938]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:48 volumio sudo[5940]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 17:59:48 volumio sudo[5940]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:48 volumio volumio[1220]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 23 17:59:48 volumio volumio[1220]: info: PLUGIN START: peppymeterbasic Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 23 17:59:48 volumio volumio[1220]: info: Preparing to generate the ALSA configuration file Dec 23 17:59:48 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Dec 23 17:59:48 volumio sudo[5948]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd_aloop index=7 pcm_substreams=2 Dec 23 17:59:48 volumio sudo[5948]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:48 volumio volumio[1220]: info: Done. Dec 23 17:59:48 volumio volumio[1220]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 23 17:59:48 volumio volumio[1220]: info: Reading ALSA contributions from plugins. Dec 23 17:59:48 volumio sudo[5948]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:48 volumio volumio[1220]: info: MPD Permissions set Dec 23 17:59:48 volumio volumio[1220]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 23 17:59:48 volumio volumio[1220]: info: snd_dummy loaded Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: Starting Shairport Sync Dec 23 17:59:48 volumio volumio[1220]: info: Asound.conf file unchanged, so no further update is needed Dec 23 17:59:48 volumio volumio[1220]: info: Output device has changed, restarting MPD Dec 23 17:59:48 volumio sudo[5956]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 23 17:59:48 volumio sudo[5956]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:48 volumio volumio[1220]: info: Output device has changed, restarting Shairport Sync Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:48 volumio sudo[5958]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 23 17:59:48 volumio sudo[5958]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:48 volumio sudo[5958]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 23 17:59:48 volumio sudo[5961]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 23 17:59:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 23 17:59:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:48 volumio systemd[1]: shairport-sync.service: Consumed 1.578s CPU time. Dec 23 17:59:48 volumio sudo[5961]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:48 volumio volumio[1220]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 23 17:59:48 volumio volumio[1220]: info: MPD Permissions set Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:48 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 23 17:59:48 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 23 17:59:48 volumio systemd[1]: mpd.service: Consumed 2.439s CPU time. Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 23 17:59:48 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 23 17:59:48 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 23 17:59:48 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 23 17:59:48 volumio sudo[5956]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:48 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 23 17:59:48 volumio volumio[1220]: info: Shairport-Sync Started Dec 23 17:59:48 volumio volumio[1220]: info: Starting Shairport Sync Dec 23 17:59:48 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 23 17:59:48 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 23 17:59:48 volumio systemd[1]: mpd.service: Deactivated successfully. Dec 23 17:59:48 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Dec 23 17:59:48 volumio systemd[1]: mpd.socket: Deactivated successfully. Dec 23 17:59:48 volumio sudo[5983]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 23 17:59:48 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Dec 23 17:59:48 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Dec 23 17:59:48 volumio sudo[5983]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:48 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Dec 23 17:59:48 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Dec 23 17:59:48 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Dec 23 17:59:48 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Dec 23 17:59:48 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:48 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Dec 23 17:59:48 volumio sudo[5983]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:48 volumio volumio[1220]: info: Shairport-Sync Started Dec 23 17:59:48 volumio sudo[5996]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 23 17:59:48 volumio sudo[5996]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Dec 23 17:59:48 volumio sudo[5996]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:50 volumio sudo[6018]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 23 17:59:50 volumio sudo[6018]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:50 volumio sudo[6020]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 23 17:59:50 volumio sudo[6020]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:50 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 23 17:59:50 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 23 17:59:50 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 23 17:59:50 volumio mpd[6014]: 2025-12-23T17:59:50 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 23 17:59:51 volumio systemd[1]: Started mpd.service - Music Player Daemon. Dec 23 17:59:51 volumio sudo[5940]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:51 volumio sudo[5961]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:51 volumio volumio[1220]: error: MPD error: The expression evaluated to a falsy value: Dec 23 17:59:51 volumio volumio[1220]: assert.ok(self.idling) Dec 23 17:59:51 volumio volumio[1220]: error: The expression evaluated to a falsy value: Dec 23 17:59:51 volumio volumio[1220]: assert.ok(self.idling) Dec 23 17:59:51 volumio volumio[1220]: error: updateQueue error: null Dec 23 17:59:51 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 23 17:59:51 volumio sudo[6018]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:51 volumio sudo[6020]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:51 volumio volumio[1220]: info: Successfully started MPD Monitor Dec 23 17:59:51 volumio mpd_monitor.sh[6025]: MPD Monitor Service: Starting MPD Monitor Service Dec 23 17:59:51 volumio volumio[1220]: info: Successfully started MPD Monitor Dec 23 17:59:54 volumio sudo[6040]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 23 17:59:54 volumio sudo[6040]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:54 volumio sudo[6043]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd_monitor.service Dec 23 17:59:54 volumio sudo[6043]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 23 17:59:54 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 23 17:59:54 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 23 17:59:54 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 23 17:59:54 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 23 17:59:54 volumio mpd_monitor.sh[6045]: MPD Monitor Service: Starting MPD Monitor Service Dec 23 17:59:54 volumio sudo[6040]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:54 volumio volumio[1220]: info: Successfully started MPD Monitor Dec 23 17:59:54 volumio systemd[1]: Stopping mpd_monitor.service - MPD Monitor Service... Dec 23 17:59:54 volumio systemd[1]: mpd_monitor.service: Deactivated successfully. Dec 23 17:59:54 volumio systemd[1]: Stopped mpd_monitor.service - MPD Monitor Service. Dec 23 17:59:54 volumio systemd[1]: Started mpd_monitor.service - MPD Monitor Service. Dec 23 17:59:54 volumio sudo[6043]: pam_unix(sudo:session): session closed for user root Dec 23 17:59:54 volumio volumio[1220]: info: Successfully started MPD Monitor Dec 23 17:59:54 volumio mpd_monitor.sh[6049]: MPD Monitor Service: Starting MPD Monitor Service Dec 23 17:59:57 volumio volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 18:00:06 volumio volumio[1220]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Dec 23 18:00:06 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Dec 23 18:00:06 volumio volumio[1220]: aaaaaaaaaaa 320,240 Dec 23 18:00:06 volumio volumio[1220]: info: PeppyMeterBasic ---320240 Dec 23 18:00:06 volumio volumio[1220]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 23 18:00:06 volumio volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 18:00:06 volumio volumio[1220]: info: CoreCommandRouter::Close All Modals sent Dec 23 18:00:09 volumio volumio[1220]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Dec 23 18:00:09 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Dec 23 18:00:09 volumio volumio[1220]: aaaaaaaaaaa 480,320 Dec 23 18:00:09 volumio volumio[1220]: info: PeppyMeterBasic ---480320 Dec 23 18:00:09 volumio volumio[1220]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 23 18:00:09 volumio volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 18:00:09 volumio volumio[1220]: info: CoreCommandRouter::Close All Modals sent Dec 23 18:00:15 volumio volumio[1220]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Dec 23 18:00:15 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Dec 23 18:00:15 volumio volumio[1220]: aaaaaaaaaaa 800,480 Dec 23 18:00:15 volumio volumio[1220]: info: PeppyMeterBasic ---800480 Dec 23 18:00:15 volumio volumio[1220]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 23 18:00:15 volumio volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 18:00:15 volumio volumio[1220]: info: CoreCommandRouter::Close All Modals sent Dec 23 18:00:23 volumio volumio[1220]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Dec 23 18:00:23 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Dec 23 18:00:23 volumio volumio[1220]: aaaaaaaaaaa 1280,400 Dec 23 18:00:23 volumio volumio[1220]: info: PeppyMeterBasic ---1280400 Dec 23 18:00:23 volumio volumio[1220]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 23 18:00:23 volumio volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 18:00:23 volumio volumio[1220]: info: CoreCommandRouter::Close All Modals sent Dec 23 18:00:24 volumio volumio[1220]: info: CALLMETHOD: user_interface peppymeterbasic savepeppy [object Object] Dec 23 18:00:24 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , savepeppy Dec 23 18:00:24 volumio volumio[1220]: aaaaaaaaaaa 1280,400 Dec 23 18:00:24 volumio volumio[1220]: info: PeppyMeterBasic ---1280400 Dec 23 18:00:24 volumio volumio[1220]: error: Failed callmethod call: TypeError: Cannot read properties of undefined (reading 'then') Dec 23 18:00:24 volumio volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 18:00:24 volumio volumio[1220]: info: CoreCommandRouter::Close All Modals sent Dec 23 18:00:31 volumio volumio[1220]: info: CALLMETHOD: user_interface peppymeterbasic updatelist Dec 23 18:00:31 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , updatelist Dec 23 18:00:31 volumio volumio[1220]: info: PeppyMeterBasic --- wget 'https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt' Dec 23 18:00:31 volumio volumio[1220]: --2025-12-23 18:00:31-- https://github.com/balbuze/Meter-peppymeter/raw/main/meterslist.txt Dec 23 18:00:31 volumio volumio[1220]: Resolving github.com (github.com)... 140.82.121.3 Dec 23 18:00:31 volumio volumio[1220]: Connecting to github.com (github.com)|140.82.121.3|:443... connected. Dec 23 18:00:31 volumio volumio[1220]: HTTP request sent, awaiting response... 302 Found Dec 23 18:00:31 volumio volumio[1220]: Location: https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt [following] Dec 23 18:00:31 volumio volumio[1220]: --2025-12-23 18:00:31-- https://raw.githubusercontent.com/balbuze/Meter-peppymeter/main/meterslist.txt Dec 23 18:00:31 volumio volumio[1220]: Resolving raw.githubusercontent.com (raw.githubusercontent.com)... 185.199.110.133, 185.199.108.133, 185.199.109.133, ... Dec 23 18:00:31 volumio volumio[1220]: Connecting to raw.githubusercontent.com (raw.githubusercontent.com)|185.199.110.133|:443... connected. Dec 23 18:00:31 volumio volumio[1220]: HTTP request sent, awaiting response... 200 OK Dec 23 18:00:31 volumio volumio[1220]: Length: 362 [text/plain] Dec 23 18:00:31 volumio volumio[1220]: Saving to: ‘/data/plugins/user_interface/peppymeterbasic/meterslist.txt’ Dec 23 18:00:31 volumio volumio[1220]: 0K 100% 8.77M=0s Dec 23 18:00:31 volumio volumio[1220]: 2025-12-23 18:00:31 (8.77 MB/s) - ‘/data/plugins/user_interface/peppymeterbasic/meterslist.txt’ saved [362/362] Dec 23 18:00:31 volumio volumio[1220]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 23 18:00:31 volumio volumio[1220]: info: CoreCommandRouter::Close All Modals sent Dec 23 18:00:36 volumio volumio[1220]: info: CALLMETHOD: user_interface peppymeterbasic dlmeter [object Object] Dec 23 18:00:36 volumio volumio[1220]: info: CoreCommandRouter::executeOnPlugin: peppymeterbasic , dlmeter Dec 23 18:00:37 volumio volumio[1220]: --2025-12-23 18:00:36-- https://github.com/balbuze/Meter-peppymeter/raw/main/Zipped-folders/Choose Dec 23 18:00:37 volumio volumio[1220]: Resolving github.com (github.com)... 140.82.121.3 Dec 23 18:00:37 volumio volumio[1220]: Connecting to github.com (github.com)|140.82.121.3|:443... connected. Dec 23 18:00:37 volumio volumio[1220]: HTTP request sent, awaiting response... 404 Not Found Dec 23 18:00:37 volumio volumio[1220]: 2025-12-23 18:00:36 ERROR 404: Not Found. Dec 23 18:00:37 volumio volumio[1220]: --2025-12-23 18:00:36-- http://a/ Dec 23 18:00:37 volumio volumio[1220]: Resolving a (a)... failed: Device or resource busy. Dec 23 18:00:37 volumio volumio[1220]: wget: unable to resolve host address ‘a’ Dec 23 18:00:37 volumio volumio[1220]: --2025-12-23 18:00:36-- http://packet.zip/ Dec 23 18:00:37 volumio volumio[1220]: Resolving packet.zip (packet.zip)... 162.255.119.167 Dec 23 18:00:37 volumio volumio[1220]: Connecting to packet.zip (packet.zip)|162.255.119.167|:80... connected. Dec 23 18:00:37 volumio volumio[1220]: HTTP request sent, awaiting response... 302 Found Dec 23 18:00:37 volumio volumio[1220]: Location: http://www.packet.zip/ [following] Dec 23 18:00:37 volumio volumio[1220]: --2025-12-23 18:00:37-- http://www.packet.zip/ Dec 23 18:00:37 volumio volumio[1220]: Resolving www.packet.zip (www.packet.zip)... 91.195.240.19 Dec 23 18:00:37 volumio volumio[1220]: Connecting to www.packet.zip (www.packet.zip)|91.195.240.19|:80... connected. Dec 23 18:00:37 volumio volumio[1220]: HTTP request sent, awaiting response... 403 Forbidden Dec 23 18:00:37 volumio volumio[1220]: 2025-12-23 18:00:37 ERROR 403: Forbidden. Dec 23 18:00:37 volumio volumio[1220]: error: PeppyMeterBasic --- An error occurs while downloading or installing Meters Dec 23 18:00:37 volumio volumio[1220]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 23 18:00:37 volumio volumio[1220]: /bin/rm: cannot remove 'a': No such file or directory Dec 23 18:00:37 volumio volumio[1220]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 23 18:00:37 volumio volumio[1220]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 18:00:37 volumio volumio[1220]: Error: Command failed: /bin/rm /tmp/Choose a packet.zip* Dec 23 18:00:37 volumio volumio[1220]: /bin/rm: cannot remove '/tmp/Choose': No such file or directory Dec 23 18:00:37 volumio volumio[1220]: /bin/rm: cannot remove 'a': No such file or directory Dec 23 18:00:37 volumio volumio[1220]: /bin/rm: cannot remove 'packet.zip*': No such file or directory Dec 23 18:00:37 volumio volumio[1220]: at checkExecSyncError (node:child_process:887:11) Dec 23 18:00:37 volumio volumio[1220]: at execSync (node:child_process:959:15) Dec 23 18:00:37 volumio volumio[1220]: at /data/plugins/user_interface/peppymeterbasic/index.js:710:19 Dec 23 18:00:37 volumio volumio[1220]: at new Promise () Dec 23 18:00:37 volumio volumio[1220]: at peppymeterbasic.dlmeter (/data/plugins/user_interface/peppymeterbasic/index.js:685:12) Dec 23 18:00:37 volumio volumio[1220]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1096:32) Dec 23 18:00:37 volumio volumio[1220]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:337:42) Dec 23 18:00:37 volumio volumio[1220]: at Socket.emit (node:events:514:28) Dec 23 18:00:37 volumio volumio[1220]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 23 18:00:37 volumio volumio[1220]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) { Dec 23 18:00:37 volumio volumio[1220]: status: 1, Dec 23 18:00:37 volumio volumio[1220]: signal: null, Dec 23 18:00:37 volumio volumio[1220]: output: [ Dec 23 18:00:37 volumio volumio[1220]: null, Dec 23 18:00:37 volumio volumio[1220]: , Dec 23 18:00:37 volumio volumio[1220]: Dec 23 18:00:37 volumio volumio[1220]: ], Dec 23 18:00:37 volumio volumio[1220]: pid: 6144, Dec 23 18:00:37 volumio volumio[1220]: stdout: , Dec 23 18:00:37 volumio volumio[1220]: stderr: Dec 23 18:00:37 volumio volumio[1220]: } Dec 23 18:00:37 volumio volumio[1220]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 23 18:00:37 volumio sudo[6161]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-23 17:59' Dec 23 18:00:37 volumio sudo[6161]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"