Apr 12 09:29:03 volumio volumio[1367]: info: Get:6 http://raspbian.raspberrypi.com/raspbian bookworm/contrib armhf Packages [62.3 kB] Apr 12 09:29:03 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:03.073+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:04 volumio volumio[1367]: info: Get:7 http://raspbian.raspberrypi.com/raspbian bookworm/non-free armhf Packages [118 kB] Apr 12 09:29:04 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:04.180+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:05 volumio volumio[1367]: info: Get:8 http://raspbian.raspberrypi.com/raspbian bookworm/rpi armhf Packages [1360 B] Apr 12 09:29:05 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:05.561+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:05 volumio volumio[1367]: info: Fetched 15.3 MB in 12s (1242 kB/s) Apr 12 09:29:05 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:05.584+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:06 volumio volumio[1367]: info: Reading package lists... Apr 12 09:29:06 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:06.737+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: Building dependency tree... Apr 12 09:29:07 volumio volumio[1367]: info: Reading state information... Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.012+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.012+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: 36 packages can be upgraded. Run 'apt list --upgradable' to see them. Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.052+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio sudo[2679]: pam_unix(sudo:session): session closed for user root Apr 12 09:29:07 volumio sudo[2874]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt-get install -y mpv Apr 12 09:29:07 volumio sudo[2874]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Apr 12 09:29:07 volumio volumio[1367]: info: Reading package lists... Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.103+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: Building dependency tree... Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.357+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: Reading state information... Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.359+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: The following additional packages will be installed: Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.851+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: cpp cpp-12 libdvdnav4 libdvdread8 libegl-mesa0 libegl1 libfile-basedir-perl Apr 12 09:29:07 volumio volumio[1367]: info: libfile-desktopentry-perl libfile-mimeinfo-perl libfontenc1 libgles2 libice6 Apr 12 09:29:07 volumio volumio[1367]: info: libio-stringy-perl libipc-system-simple-perl libisl23 liblua5.2-0 libmpc3 Apr 12 09:29:07 volumio volumio[1367]: info: libmpfr6 libmujs2 libnet-dbus-perl libsixel1 libsm6 libtie-ixhash-perl Apr 12 09:29:07 volumio volumio[1367]: info: libuchardet0 libva-wayland2 libx11-protocol-perl libxaw7 libxcomposite1 Apr 12 09:29:07 volumio volumio[1367]: info: libxft2 libxinerama1 libxkbfile1 libxml-parser-perl libxml-twig-perl Apr 12 09:29:07 volumio volumio[1367]: info: libxml-xpathengine-perl libxmu6 libxmuu1 libxpm4 libxpresent1 libxt6 Apr 12 09:29:07 volumio volumio[1367]: info: libxtst6 libxxf86dga1 python3-brotli python3-mutagen python3-pyxattr Apr 12 09:29:07 volumio volumio[1367]: info: python3-websockets rtmpdump x11-utils x11-xserver-utils xdg-utils yt-dlp Apr 12 09:29:07 volumio volumio[1367]: info: zutty Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.853+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.856+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: Suggested packages: Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.861+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: cpp-doc gcc-12-locales cpp-12-doc libdvdcss2 libunicode-map8-perl Apr 12 09:29:07 volumio volumio[1367]: info: libunicode-string-perl xml-twig-tools python-mutagen-doc python-pyxattr-doc Apr 12 09:29:07 volumio volumio[1367]: info: mesa-utils nickle cairo-5c xorg-docs-core libfribidi-bin | bidiv phantomjs Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.863+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.863+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.863+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: The following NEW packages will be installed: Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.890+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: cpp cpp-12 libdvdnav4 libdvdread8 libegl-mesa0 libegl1 libfile-basedir-perl Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.892+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: libfile-desktopentry-perl libfile-mimeinfo-perl libfontenc1 libgles2 libice6 Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.894+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: libio-stringy-perl libipc-system-simple-perl libisl23 liblua5.2-0 libmpc3 Apr 12 09:29:07 volumio volumio[1367]: info: libmpfr6 libmujs2 libnet-dbus-perl libsixel1 libsm6 libtie-ixhash-perl Apr 12 09:29:07 volumio volumio[1367]: info: libuchardet0 libva-wayland2 libx11-protocol-perl libxaw7 libxcomposite1 Apr 12 09:29:07 volumio volumio[1367]: info: libxft2 libxinerama1 libxkbfile1 libxml-parser-perl libxml-twig-perl Apr 12 09:29:07 volumio volumio[1367]: info: libxml-xpathengine-perl libxmu6 libxmuu1 libxpm4 libxpresent1 libxt6 Apr 12 09:29:07 volumio volumio[1367]: info: libxtst6 libxxf86dga1 mpv python3-brotli python3-mutagen python3-pyxattr Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.897+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.897+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.897+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.897+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.898+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.898+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio[1367]: info: python3-websockets rtmpdump x11-utils x11-xserver-utils xdg-utils yt-dlp Apr 12 09:29:07 volumio volumio[1367]: info: zutty Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.905+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:07 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:07.906+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:08 volumio volumio[1367]: info: 0 upgraded, 52 newly installed, 0 to remove and 36 not upgraded. Apr 12 09:29:08 volumio volumio[1367]: info: Need to get 14.5 MB of archives. Apr 12 09:29:08 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:08.508+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:08 volumio volumio[1367]: info: After this operation, 50.9 MB of additional disk space will be used. Apr 12 09:29:08 volumio volumio[1367]: info: Get:1 http://archive.raspberrypi.com/debian bookworm/main armhf libegl-mesa0 armhf 24.2.8-1~bpo12+rpt4 [141 kB] Apr 12 09:29:08 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:08.510+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:08 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:08.510+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:08 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:08.510+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:09 volumio volumio[1367]: info: Get:2 http://mirror.rise.ph/raspbian/raspbian bookworm/main armhf libisl23 armhf 0.25-1.1 [517 kB] Apr 12 09:29:09 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:09.228+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:09 volumio volumio[1367]: info: Get:3 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libmpfr6 armhf 4.2.0-1 [574 kB] Apr 12 09:29:09 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:09.330+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:09 volumio volumio[1367]: info: Get:4 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libmpc3 armhf 1.3.1-1 [41.0 kB] Apr 12 09:29:09 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:09.944+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:11 volumio volumio[1367]: info: Get:6 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf cpp armhf 4:12.2.0-3+rpi1 [7048 B] Apr 12 09:29:11 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:11.240+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:11 volumio volumio[1367]: info: Get:7 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libdvdread8 armhf 6.1.3-1 [87.4 kB] Apr 12 09:29:11 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:11.892+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:12 volumio volumio[1367]: info: Get:8 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libdvdnav4 armhf 6.1.1-1 [43.3 kB] Apr 12 09:29:12 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:12.515+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:13 volumio volumio[1367]: info: Get:9 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libegl1 armhf 1.6.0-1 [28.3 kB] Apr 12 09:29:13 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:13.172+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:14 volumio volumio[1367]: info: Get:10 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libipc-system-simple-perl all 1.30-2 [26.8 kB] Apr 12 09:29:14 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:14.408+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:14 volumio volumio[1367]: info: Get:11 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libfile-basedir-perl all 0.09-2 [15.1 kB] Apr 12 09:29:14 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:14.989+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:15 volumio volumio[1367]: info: Get:12 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libfile-desktopentry-perl all 0.22-3 [17.6 kB] Apr 12 09:29:15 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:15.652+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:16 volumio volumio[1367]: info: Get:13 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libfile-mimeinfo-perl all 0.33-1 [48.3 kB] Apr 12 09:29:16 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:16.328+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:16 volumio volumio[1367]: info: Get:14 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libfontenc1 armhf 1:1.1.4-1 [22.3 kB] Apr 12 09:29:16 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:16.961+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:17 volumio volumio[1367]: info: Get:15 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libgles2 armhf 1.6.0-1 [17.2 kB] Apr 12 09:29:17 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:17.579+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:18 volumio volumio[1367]: info: Get:16 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libice6 armhf 2:1.0.10-1 [51.7 kB] Apr 12 09:29:18 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:18.311+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:18 volumio volumio[1367]: info: Get:17 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libio-stringy-perl all 2.111-3 [56.5 kB] Apr 12 09:29:18 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:18.949+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:19 volumio volumio[1367]: info: Get:18 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf liblua5.2-0 armhf 5.2.4-3 [85.7 kB] Apr 12 09:29:19 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:19.599+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:20 volumio volumio[1367]: info: Get:19 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libmujs2 armhf 1.3.2-1 [90.7 kB] Apr 12 09:29:20 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:20.274+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:21 volumio volumio[1367]: info: Get:20 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libxml-parser-perl armhf 2.46-4+deb12u1 [197 kB] Apr 12 09:29:21 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:21.101+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:21 volumio volumio[1367]: info: Get:21 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxml-twig-perl all 1:3.52-2 [181 kB] Apr 12 09:29:21 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:21.538+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:22 volumio volumio[1367]: info: Get:22 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libnet-dbus-perl armhf 1.2.0-2 [174 kB] Apr 12 09:29:22 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:22.235+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:22 volumio volumio[1367]: info: Get:23 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libsixel1 armhf 1.10.3-3 [81.1 kB] Apr 12 09:29:22 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:22.853+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:23 volumio volumio[1367]: info: Get:24 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libsm6 armhf 2:1.2.3-1 [32.9 kB] Apr 12 09:29:23 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:23.573+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:24 volumio volumio[1367]: info: Get:25 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libtie-ixhash-perl all 1.23-4 [11.7 kB] Apr 12 09:29:24 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:24.154+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:24 volumio volumio[1367]: info: Get:26 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libuchardet0 armhf 0.0.7-1 [65.0 kB] Apr 12 09:29:24 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:24.818+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:25 volumio volumio[1367]: info: Get:27 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libva-wayland2 armhf 2.17.0-1 [17.1 kB] Apr 12 09:29:25 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:25.551+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:26 volumio volumio[1367]: info: Get:28 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libx11-protocol-perl all 0.56-9 [120 kB] Apr 12 09:29:26 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:26.357+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:26 volumio volumio[1367]: info: Get:29 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxt6 armhf 1:1.2.1-1.1 [155 kB] Apr 12 09:29:26 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:26.803+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:27 volumio volumio[1367]: info: Get:30 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxmu6 armhf 2:1.1.3-3 [52.0 kB] Apr 12 09:29:27 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:27.447+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:28 volumio volumio[1367]: info: Get:31 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libxpm4 armhf 1:3.5.12-1.1+deb12u1 [37.7 kB] Apr 12 09:29:28 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:28.179+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:28 volumio volumio[1367]: info: Get:32 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxaw7 armhf 2:1.0.14-1 [165 kB] Apr 12 09:29:28 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:28.768+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:29 volumio volumio[1367]: info: Get:33 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxcomposite1 armhf 1:0.4.5-1 [16.2 kB] Apr 12 09:29:29 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:29.416+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:30 volumio volumio[1367]: info: Get:34 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxft2 armhf 2.3.6-1 [53.7 kB] Apr 12 09:29:30 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:30.068+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:30 volumio volumio[1367]: info: Get:35 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxinerama1 armhf 2:1.1.4-3 [17.4 kB] Apr 12 09:29:30 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:30.687+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:31 volumio volumio[1367]: info: Get:36 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxkbfile1 armhf 1:1.1.0-1 [66.4 kB] Apr 12 09:29:31 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:31.361+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:32 volumio volumio[1367]: info: Get:37 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxml-xpathengine-perl all 0.14-2 [33.5 kB] Apr 12 09:29:32 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:32.057+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:32 volumio volumio[1367]: info: Get:38 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxmuu1 armhf 2:1.1.3-3 [23.3 kB] Apr 12 09:29:32 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:32.663+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:33 volumio volumio[1367]: info: Get:39 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxpresent1 armhf 1.0.0-2 [7316 B] Apr 12 09:29:33 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:33.342+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:33 volumio volumio[1367]: info: Get:40 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxtst6 armhf 2:1.2.3-1.1 [26.3 kB] Apr 12 09:29:33 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:33.988+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:34 volumio volumio[1367]: info: Get:41 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf libxxf86dga1 armhf 2:1.1.5-1 [20.9 kB] Apr 12 09:29:34 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:34.614+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:36 volumio volumio[1367]: info: Get:42 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf mpv armhf 0.35.1-4 [1042 kB] Apr 12 09:29:36 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:36.321+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:36 volumio volumio[1367]: info: Get:43 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf python3-brotli armhf 1.0.9-2+b3 [278 kB] Apr 12 09:29:36 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:36.411+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:36 volumio volumio[1367]: info: Get:44 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf python3-mutagen all 1.46.0-1 [135 kB] Apr 12 09:29:36 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:36.568+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:37 volumio volumio[1367]: info: Get:45 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf python3-pyxattr armhf 0.8.1-1 [15.8 kB] Apr 12 09:29:37 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:37.220+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:37 volumio volumio[1367]: info: Get:46 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf python3-websockets all 10.4-1 [62.8 kB] Apr 12 09:29:37 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:37.896+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:38 volumio volumio[1367]: info: Get:47 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf rtmpdump armhf 2.4+20151223.gitfa8646d.1-2+b2 [47.7 kB] Apr 12 09:29:38 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:38.553+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:39 volumio volumio[1367]: info: Get:48 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf x11-utils armhf 7.7+5 [176 kB] Apr 12 09:29:39 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:39.195+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:39 volumio volumio[1367]: info: Get:49 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf x11-xserver-utils armhf 7.7+9 [151 kB] Apr 12 09:29:39 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:39.806+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:42 volumio volumio[1367]: info: Ign:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf cpp-12 armhf 12.2.0-14+rpi1+deb12u1 Apr 12 09:29:42 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:42.848+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:42 volumio volumio[1367]: info: Get:50 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf xdg-utils all 1.1.3-4.1 [75.5 kB] Apr 12 09:29:42 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:42.886+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:42 volumio volumio[1367]: info: Get:51 http://ftp.kaist.ac.kr/raspbian/raspbian bookworm/main armhf yt-dlp all 2023.03.04-1 [1778 kB] Apr 12 09:29:42 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:42.961+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:43 volumio volumio[1367]: info: Get:52 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf zutty armhf 0.14.0.20230218+dfsg1-1 [155 kB] Apr 12 09:29:43 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:43.071+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:43 volumio volumio[1367]: info: Ign:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf cpp-12 armhf 12.2.0-14+rpi1+deb12u1 Apr 12 09:29:43 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:43.848+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:45 volumio volumio[1367]: info: Ign:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf cpp-12 armhf 12.2.0-14+rpi1+deb12u1 Apr 12 09:29:45 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:45.848+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:49 volumio volumio[1367]: info: Err:5 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf cpp-12 armhf 12.2.0-14+rpi1+deb12u1 Apr 12 09:29:49 volumio volumio[1367]: info: Could not connect to mirror.ossplanet.net:80 (163.22.17.70), connection timed out Apr 12 09:29:49 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:49.857+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:49 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:49.857+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:49 volumio volumio[1367]: info: Fetched 7341 kB in 42s (175 kB/s) Apr 12 09:29:49 volumio sudo[2874]: pam_unix(sudo:session): session closed for user root Apr 12 09:29:49 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:49.870+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:49 volumio sudo[2677]: pam_unix(sudo:session): session closed for user root Apr 12 09:29:49 volumio volumio[1367]: info: RP2 plugin installed Apr 12 09:29:49 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:49.873+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:49 volumio volumio[1367]: Plugin install end detected on script Apr 12 09:29:49 volumio volumio[1367]: info: Install script completed Apr 12 09:29:49 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:49.879+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:49 volumio volumio[1367]: info: Adding reference to registry Apr 12 09:29:49 volumio volumio[1367]: info: Done installing plugin. Apr 12 09:29:49 volumio volumio5-onboarding[1684]: time=2026-04-12T09:29:49.883+09:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Apr 12 09:29:49 volumio volumio[1367]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 12 09:29:49 volumio volumio[1367]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 12 09:29:49 volumio volumio[1367]: info: Folder /tmp/plugins removed Apr 12 09:29:49 volumio volumio[1367]: info: Folder /tmp/downloaded_plugin.zip removed Apr 12 09:29:49 volumio volumio[1367]: info: Folder /data/temp removed Apr 12 09:29:53 volumio volumio[1367]: info: Enabling plugin rp2 Apr 12 09:29:53 volumio volumio[1367]: info: Loading plugin "rp2"... Apr 12 09:29:53 volumio volumio[1367]: info: PLUGIN START: rp2 Apr 12 09:29:53 volumio volumio[1367]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 12 09:29:53 volumio volumio[1367]: info: [1775953793557] CoreMusicLibrary::Adding element Radio Paradise (RP2) Apr 12 09:29:53 volumio volumio[1367]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 09:29:53 volumio volumio[1367]: Cannot find translation for source 개인 라디오 Apr 12 09:29:53 volumio volumio[1367]: Cannot find translation for source Radio Paradise (RP2) Apr 12 09:29:53 volumio volumio[1367]: info: Done. Apr 12 09:29:54 volumio volumio[1367]: info: Enabling plugin rp2 Apr 12 09:29:54 volumio volumio[1367]: info: Loading plugin "rp2"... Apr 12 09:29:54 volumio volumio[1367]: info: PLUGIN START: rp2 Apr 12 09:29:54 volumio volumio[1367]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 12 09:29:54 volumio volumio[1367]: info: [1775953794582] CoreMusicLibrary::Adding element Radio Paradise (RP2) Apr 12 09:29:54 volumio volumio[1367]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 12 09:29:54 volumio volumio[1367]: Cannot find translation for source 개인 라디오 Apr 12 09:29:54 volumio volumio[1367]: Cannot find translation for source Radio Paradise (RP2) Apr 12 09:29:54 volumio volumio[1367]: info: Done. Apr 12 09:30:01 volumio volumio[1367]: info: CoreCommandRouter::executeOnPlugin: rp2 , handleBrowseUri Apr 12 09:30:02 volumio volumio[1367]: info: Preload queue cleared Apr 12 09:30:10 volumio volumio[1367]: info: Preload queue cleared Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::ClearQueue Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::stop Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::stPlaybackTimer Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::updateTrackBlock Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrackBlock Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 2 Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPushState Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::serviceStop Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 2 Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::serviceStop Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::stop Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand stop Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::clearPlayQueue Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::saveQueue Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPushQueue Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::addQueueItems Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::addQueueItems Apr 12 09:30:10 volumio volumio[1367]: info: Preload queue cleared Apr 12 09:30:10 volumio volumio[1367]: info: Adding Item to queue: rp2/channel@qi=%7B%22service%22%3A%22rp2%22%2C%22uri%22%3A%22rp2%2Fchannel%40id%3D0%22%2C%22name%22%3A%22The%20Main%20Mix%22%2C%22title%22%3A%22The%20Main%20Mix%22%2C%22artist%22%3A%22Radio%20Paradise%22%2C%22albumart%22%3A%22https%3A%2F%2Fimg.radioparadise.com%2Fchannels%2F0%2F0%2Fcover_512x512%2F0.jpg%22%7D Apr 12 09:30:10 volumio volumio[1367]: info: Exploding uri rp2/channel@qi=%7B%22service%22%3A%22rp2%22%2C%22uri%22%3A%22rp2%2Fchannel%40id%3D0%22%2C%22name%22%3A%22The%20Main%20Mix%22%2C%22title%22%3A%22The%20Main%20Mix%22%2C%22artist%22%3A%22Radio%20Paradise%22%2C%22albumart%22%3A%22https%3A%2F%2Fimg.radioparadise.com%2Fchannels%2F0%2F0%2Fcover_512x512%2F0.jpg%22%7D in service rp2 Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPushQueue Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::saveQueue Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::updateTrackBlock Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrackBlock Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPlay Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::play index 0 Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::stop Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::play index undefined Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::startPlaybackTimer Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: [rp2] clearAddPlayTrack: rp2/channel@id=0 Apr 12 09:30:10 volumio volumio[1367]: info: Apr 12 09:30:10 volumio volumio[1367]: ---------------------------- MPD announces state update: player Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand stop took 19 milliseconds Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::getState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::getState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Apr 12 09:30:10 volumio volumio[1367]: info: Apr 12 09:30:10 volumio volumio[1367]: ---------------------------- MPD announces state update: player Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::getState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Apr 12 09:30:10 volumio volumio[1367]: info: Apr 12 09:30:10 volumio volumio[1367]: ---------------------------- MPD announces state update: player Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::getState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand status Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand status took 3 milliseconds Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand status took 2 milliseconds Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand status took 2 milliseconds Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand status took 1 milliseconds Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseState Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseTrackInfo Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::servicePushState Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rp2 Received mpd Apr 12 09:30:10 volumio volumio[1367]: info: ------------------------------ 9ms Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 12 09:30:10 volumio volumio[1367]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseTrackInfo Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseTrackInfo Apr 12 09:30:10 volumio volumio[1367]: verbose: ControllerMpd::parseTrackInfo Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rp2 Received personal_radio Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::servicePushState Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rp2 Received mpd Apr 12 09:30:10 volumio volumio[1367]: info: ControllerMpd::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::servicePushState Apr 12 09:30:10 volumio volumio[1367]: info: CoreStateMachine::pushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: CoreCommandRouter::volumioPushState Apr 12 09:30:10 volumio volumio[1367]: info: CorePlayQueue::getTrack 0 Apr 12 09:30:10 volumio volumio[1367]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current rp2 Received mpd Apr 12 09:30:10 volumio volumio[1367]: info: ------------------------------ 15ms Apr 12 09:30:10 volumio volumio[1367]: info: ------------------------------ 14ms Apr 12 09:30:10 volumio volumio[1367]: verbose: [rp2] API: https://api.radioparadise.com/api/play?source=24&event=0&elapsed=0&bitrate=4&action=start&player_id=********&info=true&chan=0&audio_type= Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] Obtained block for channel "0" Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] ------------- Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] Block summary Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] ------------- Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] Stream URL: https://audio-geo.radioparadise.com/chan/0/x/2173/4/b/2173-0.flac Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] Tracks: Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] 0. Ends Of The Earth (4:33 | elapsed: 15m 47s) Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] 1. Call Me The Breeze (2:31 | elapsed: 20m 20s) Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] 2. Unconditional I (Lookout Kid) (4:32 | elapsed: 22m 52s) Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] Apr 12 09:30:11 volumio volumio[1367]: verbose: [rp2] Current track scheduled playback vs. current time: 4/12/2026, 9:27:06 AM <-> 4/12/2026, 9:30:11 AM Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] Going to start playback of current track at 3:05 (track position in stream: 15:47) Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] Starting mpv Apr 12 09:30:11 volumio volumio[1367]: /bin/sh: 1: mpv: not found Apr 12 09:30:11 volumio volumio[1367]: error: [rp2] [mpv] Failed to get mpv version: Command failed: mpv --version Apr 12 09:30:11 volumio volumio[1367]: /bin/sh: 1: mpv: not found Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] [mpv] mpv process spawned Apr 12 09:30:11 volumio volumio[1367]: verbose: [rp2] Waiting for player event "playing"... Apr 12 09:30:11 volumio volumio[1367]: info: [rp2] [mpv] (PID: 3116) /bin/sh: 1: mpv: not found Apr 12 09:30:11 volumio volumio[1367]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 09:30:11 volumio volumio[1367]: TypeError: Cannot read properties of null (reading 'reset') Apr 12 09:30:11 volumio volumio[1367]: at /data/plugins/music_service/rp2/node_modules/volumio-ext-players/dist/mpv/MPVService.js:207:48 Apr 12 09:30:11 volumio volumio[1367]: at ChildProcess. (/data/plugins/music_service/rp2/node_modules/volumio-ext-players/dist/mpv/MPVService.js:221:19) Apr 12 09:30:11 volumio volumio[1367]: at ChildProcess.emit (node:events:514:28) Apr 12 09:30:11 volumio volumio[1367]: at maybeClose (node:internal/child_process:1105:16) Apr 12 09:30:11 volumio volumio[1367]: at Socket. (node:internal/child_process:457:11) Apr 12 09:30:11 volumio volumio[1367]: at Socket.emit (node:events:514:28) Apr 12 09:30:11 volumio volumio[1367]: at Pipe. (node:net:337:12) Apr 12 09:30:11 volumio volumio[1367]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 09:30:11 volumio sudo[3131]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-04-12 09:29' Apr 12 09:30:11 volumio sudo[3131]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"