Oct 15 19:55:03 raspi4-volumio volumio[1384]: info: Reading package lists... Oct 15 19:55:03 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:03.066Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:03 raspi4-volumio volumio[1384]: info: Reading package lists... Oct 15 19:55:03 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:03.250Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:03 raspi4-volumio volumio[1384]: info: Building dependency tree... Oct 15 19:55:03 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:03.732Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:03 raspi4-volumio volumio[1384]: info: Reading state information... Oct 15 19:55:03 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:03.739Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:06 raspi4-volumio volumio[1384]: info: The following NEW packages will be installed: Oct 15 19:55:06 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:06.876Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:06 raspi4-volumio volumio[1384]: info: patchelf Oct 15 19:55:06 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:06.891Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:07 raspi4-volumio volumio[1384]: info: 0 upgraded, 1 newly installed, 0 to remove and 93 not upgraded. Oct 15 19:55:07 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:07.250Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:07 raspi4-volumio volumio[1384]: info: Need to get 59.8 kB of archives. Oct 15 19:55:07 raspi4-volumio volumio[1384]: info: After this operation, 173 kB of additional disk space will be used. Oct 15 19:55:07 raspi4-volumio volumio[1384]: info: Get:1 http://ftp.acc.umu.se/mirror/raspbian/raspbian bookworm/main armhf patchelf armhf 0.14.3-1 [59.8 kB] Oct 15 19:55:07 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:07.256Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:07 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:07.256Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:07 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:07.257Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:07 raspi4-volumio volumio[1384]: info: Fetched 59.8 kB in 0s (158 kB/s) Oct 15 19:55:07 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:07.991Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:08 raspi4-volumio volumio[1384]: info: Selecting previously unselected package patchelf. Oct 15 19:55:08 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:08.057Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:09 raspi4-volumio volumio[1384]: [620B blob data] Oct 15 19:55:09 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:09.289Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:09 raspi4-volumio volumio[1384]: info: Preparing to unpack .../patchelf_0.14.3-1_armhf.deb ... Oct 15 19:55:09 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:09.295Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:09 raspi4-volumio volumio[1384]: info: Unpacking patchelf (0.14.3-1) ... Oct 15 19:55:09 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:09.302Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:11 raspi4-volumio volumio[1384]: info: Setting up patchelf (0.14.3-1) ... Oct 15 19:55:11 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:11.932Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:12 raspi4-volumio systemd[1]: Reloading. Oct 15 19:55:13 raspi4-volumio systemd[1]: Starting fstrim.service - Discard unused blocks on filesystems from /etc/fstab... Oct 15 19:55:13 raspi4-volumio systemd[1]: Reloading. Oct 15 19:55:13 raspi4-volumio fstrim[3679]: /boot: 273.3 MiB (286588928 bytes) trimmed on /dev/mmcblk0p1 Oct 15 19:55:14 raspi4-volumio systemd[1]: fstrim.service: Deactivated successfully. Oct 15 19:55:14 raspi4-volumio systemd[1]: Finished fstrim.service - Discard unused blocks on filesystems from /etc/fstab. Oct 15 19:55:15 raspi4-volumio volumio[1384]: info: /etc/sudoers.d/volumio-user-soloist_connect: parsed OK Oct 15 19:55:15 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:15.963Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:16 raspi4-volumio volumio[1384]: info: Downloading Spotify Soloist for userspace armhf (uname=armv7l dpkg=armhf bits=32) ... Oct 15 19:55:16 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:16.020Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:18 raspi4-volumio volumio[1384]: info: System glibc is 2.36; sideloading armhf glibc from Debian trixie... Oct 15 19:55:18 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:18.788Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:18 raspi4-volumio volumio[1384]: info: Fetching trixie package index for armhf... Oct 15 19:55:18 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:18.792Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:19 raspi4-volumio volumio[1384]: info: Downloading libc6 ... Oct 15 19:55:19 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:19.293Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:20 raspi4-volumio volumio[1384]: info: Downloading libgcc-s1 ... Oct 15 19:55:20 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:20.073Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:20 raspi4-volumio volumio[1384]: info: Downloading libstdc++6 ... Oct 15 19:55:20 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:20.329Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:20 raspi4-volumio volumio[1384]: info: Downloading libatomic1 ... Oct 15 19:55:20 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:20.706Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:23 raspi4-volumio nmbd[2742]: [2026/10/15 19:55:23.336430, 0] ../../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 15 19:55:23 raspi4-volumio nmbd[2742]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.105 for name WORKGROUP<1d>. Oct 15 19:55:23 raspi4-volumio nmbd[2742]: This response was from IP 192.168.1.241, reporting an IP address of 192.168.1.241. Oct 15 19:55:24 raspi4-volumio volumio[1384]: info: patch-soloist: patched /data/soloist/staging/soloist Oct 15 19:55:24 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:24.485Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:24 raspi4-volumio volumio[1384]: info: interpreter: /data/soloist/sysroot/usr/lib/arm-linux-gnueabihf/ld-linux-armhf.so.3 Oct 15 19:55:24 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:24.776Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:24 raspi4-volumio volumio[1384]: info: rpath: /data/soloist/sysroot/lib/arm-linux-gnueabihf:/data/soloist/sysroot/usr/lib/arm-linux-gnueabihf:/data/soloist/sysroot/lib:/data/soloist/sysroot/usr/lib Oct 15 19:55:24 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:24.893Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:24 raspi4-volumio volumio[1384]: info: Sideload complete. Test with: /data/soloist/staging/soloist --version Oct 15 19:55:24 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:24.910Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:25 raspi4-volumio volumio[1384]: info: Patched interpreter: /data/soloist/sysroot/usr/lib/arm-linux-gnueabihf/ld-linux-armhf.so.3 Oct 15 19:55:25 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:25.026Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:25 raspi4-volumio volumio[1384]: info: Staged: soloist 1.3.9.27 build 1792065788 (20261015) (g440165f200) (linux/arm) Oct 15 19:55:25 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:25.058Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:31 raspi4-volumio volumio[1384]: info: Installed: soloist 1.3.9.27 build 1792065788 (20261015) (g440165f200) (linux/arm) Oct 15 19:55:31 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:31.124Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:31 raspi4-volumio volumio[1384]: info: Start with: sudo systemctl start soloist.service Oct 15 19:55:31 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:31.130Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:31 raspi4-volumio volumio[1384]: info: Sysroot already has armhf glibc (ld-linux-armhf.so.3). Oct 15 19:55:31 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:31.219Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:33 raspi4-volumio volumio[1384]: info: patch-soloist: patched /data/soloist/bin/soloist Oct 15 19:55:33 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:33.859Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:33 raspi4-volumio volumio[1384]: info: interpreter: /data/soloist/sysroot/usr/lib/arm-linux-gnueabihf/ld-linux-armhf.so.3 Oct 15 19:55:33 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:33.977Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: rpath: /data/soloist/sysroot/lib/arm-linux-gnueabihf:/data/soloist/sysroot/usr/lib/arm-linux-gnueabihf:/data/soloist/sysroot/lib:/data/soloist/sysroot/usr/lib Oct 15 19:55:34 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:34.093Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: Sideload complete. Test with: /data/soloist/bin/soloist --version Oct 15 19:55:34 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:34.118Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:34 raspi4-volumio sudo[3455]: pam_unix(sudo:session): session closed for user root Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: Install script completed Oct 15 19:55:34 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:34.152Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: Adding reference to registry Oct 15 19:55:34 raspi4-volumio volumio5-onboarding[1956]: time=2026-10-15T16:55:34.163Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: Done installing plugin. Oct 15 19:55:34 raspi4-volumio volumio[1384]: Plugin install end detected on script Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: Folder /tmp/plugins removed Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: Folder /tmp/downloaded_plugin.zip removed Oct 15 19:55:34 raspi4-volumio volumio[1384]: info: Folder /data/temp removed Oct 15 19:55:38 raspi4-volumio volumio[1384]: info: Enabling plugin soloist_connect Oct 15 19:55:38 raspi4-volumio volumio[1384]: info: Loading plugin "soloist_connect"... Oct 15 19:55:39 raspi4-volumio volumio[1384]: info: PLUGIN START: soloist_connect Oct 15 19:55:39 raspi4-volumio volumio[1384]: info: SoloistConnect: plugin=0.9.0 shim=0.2.9 Oct 15 19:55:39 raspi4-volumio volumio[1384]: info: SoloistConnect: freshness armed period=24h Oct 15 19:55:39 raspi4-volumio volumio[1384]: info: Done. Oct 15 19:56:59 raspi4-volumio sudo[4036]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 15 19:56:59 raspi4-volumio sudo[4034]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 15 19:56:59 raspi4-volumio sudo[4034]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 19:56:59 raspi4-volumio sudo[4036]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 15 19:56:59 raspi4-volumio sudo[4034]: pam_unix(sudo:session): session closed for user root Oct 15 19:56:59 raspi4-volumio sudo[4036]: pam_unix(sudo:session): session closed for user root Oct 15 19:56:59 raspi4-volumio volumio[1384]: verbose: New Socket.io Connection to 192.168.1.105 from 192.168.1.46 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:158.0) Gecko/20100101 Firefox/158.0 Engine version: 3 Transport: polling Total Clients: 5 Oct 15 19:56:59 raspi4-volumio volumio[1384]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 15 19:56:59 raspi4-volumio volumio[1384]: info: CoreCommandRouter::volumioGetVisibleSources Oct 15 19:56:59 raspi4-volumio volumio[1384]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 15 19:56:59 raspi4-volumio volumio[1384]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 19:56:59 raspi4-volumio volumio[1384]: TypeError: Cannot read properties of undefined (reading 'plugin_type') Oct 15 19:56:59 raspi4-volumio volumio[1384]: at PluginManager.getInstalledPlugins (/volumio/app/pluginmanager.js:1644:56) Oct 15 19:56:59 raspi4-volumio volumio[1384]: at CoreCommandRouter.getInstalledPlugins (/volumio/app/index.js:1540:29) Oct 15 19:56:59 raspi4-volumio volumio[1384]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1353:45) Oct 15 19:56:59 raspi4-volumio volumio[1384]: at Socket.emit (node:events:514:28) Oct 15 19:56:59 raspi4-volumio volumio[1384]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Oct 15 19:56:59 raspi4-volumio volumio[1384]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Oct 15 19:56:59 raspi4-volumio volumio[1384]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 15 19:56:59 raspi4-volumio sudo[4053]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-15 19:55' Oct 15 19:56:59 raspi4-volumio sudo[4053]: 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"