Feb 18 21:41:16 volumio volumio[1239]: info: Fetched 15.3 MB in 28s (546 kB/s) Feb 18 21:41:16 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:16.956Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:30 volumio volumio[1239]: info: Reading package lists... Feb 18 21:41:30 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:30.630Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:38 volumio volumio[1239]: info: Building dependency tree... Feb 18 21:41:38 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:38.997Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:39 volumio volumio[1239]: info: Reading state information... Feb 18 21:41:39 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:39.893Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:40 volumio volumio[1239]: info: 4 packages can be upgraded. Run 'apt list --upgradable' to see them. Feb 18 21:41:40 volumio sudo[4962]: pam_unix(sudo:session): session closed for user root Feb 18 21:41:40 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:40.208Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:43 volumio sudo[5189]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/apt install -y evtest Feb 18 21:41:43 volumio sudo[5189]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:41:44 volumio volumio[1239]: info: Reading package lists... Feb 18 21:41:44 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:44.264Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:46 volumio volumio[1239]: info: Building dependency tree... Feb 18 21:41:46 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:46.221Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:46 volumio volumio[1239]: info: Reading state information... Feb 18 21:41:46 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:46.261Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:49 volumio volumio[1239]: info: The following additional packages will be installed: Feb 18 21:41:49 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:49.287Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:49 volumio volumio[1239]: info: evemu-tools libevdev2 libevemu3 Feb 18 21:41:49 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:49.331Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:49 volumio volumio[1239]: info: The following NEW packages will be installed: Feb 18 21:41:49 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:49.597Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:49 volumio volumio[1239]: info: evemu-tools evtest libevdev2 libevemu3 Feb 18 21:41:49 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:49.648Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:52 volumio volumio[1239]: info: 0 upgraded, 4 newly installed, 0 to remove and 4 not upgraded. Feb 18 21:41:52 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:52.516Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:52 volumio volumio[1239]: info: Need to get 67.5 kB of archives. Feb 18 21:41:52 volumio volumio[1239]: info: After this operation, 249 kB of additional disk space will be used. Feb 18 21:41:52 volumio volumio[1239]: info: Get:1 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf libevdev2 armhf 1.13.0+dfsg-1+rpi1 [27.9 kB] Feb 18 21:41:52 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:52.535Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:52 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:52.537Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:52 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:52.540Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:52 volumio volumio[1239]: info: Get:2 http://mirror.truenetwork.ru/raspbian/raspbian bookworm/main armhf libevemu3 armhf 2.7.0-3 [11.5 kB] Feb 18 21:41:52 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:52.674Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:52 volumio volumio[1239]: info: Get:3 http://mirror.truenetwork.ru/raspbian/raspbian bookworm/main armhf evemu-tools armhf 2.7.0-3 [14.3 kB] Feb 18 21:41:52 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:52.790Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:52 volumio volumio[1239]: info: Get:4 http://mirror.truenetwork.ru/raspbian/raspbian bookworm/main armhf evtest armhf 1:1.35-1 [13.8 kB] Feb 18 21:41:52 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:52.825Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:56 volumio volumio[1239]: info: Fetched 67.5 kB in 3s (22.6 kB/s) Feb 18 21:41:56 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:56.906Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:41:57 volumio volumio[1239]: info: Selecting previously unselected package libevdev2:armhf. Feb 18 21:41:57 volumio volumio5-onboarding[1653]: time=2026-02-18T18:41:57.309Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:01 volumio volumio[1239]: [620B blob data] Feb 18 21:42:01 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:01.886Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:01 volumio volumio[1239]: info: Preparing to unpack .../libevdev2_1.13.0+dfsg-1+rpi1_armhf.deb ... Feb 18 21:42:01 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:01.917Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:02 volumio volumio[1239]: info: Unpacking libevdev2:armhf (1.13.0+dfsg-1+rpi1) ... Feb 18 21:42:02 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:02.137Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:02 volumio volumio[1239]: info: Selecting previously unselected package libevemu3:armhf. Feb 18 21:42:02 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:02.666Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:02 volumio volumio[1239]: info: Preparing to unpack .../libevemu3_2.7.0-3_armhf.deb ... Feb 18 21:42:02 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:02.697Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:02 volumio volumio[1239]: info: Unpacking libevemu3:armhf (2.7.0-3) ... Feb 18 21:42:02 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:02.744Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:03 volumio volumio[1239]: info: Selecting previously unselected package evemu-tools. Feb 18 21:42:03 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:03.336Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:03 volumio volumio[1239]: info: Preparing to unpack .../evemu-tools_2.7.0-3_armhf.deb ... Feb 18 21:42:03 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:03.380Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:03 volumio volumio[1239]: info: Unpacking evemu-tools (2.7.0-3) ... Feb 18 21:42:03 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:03.398Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:06 volumio volumio[1239]: info: Selecting previously unselected package evtest. Feb 18 21:42:06 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:06.410Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:06 volumio volumio[1239]: info: Preparing to unpack .../evtest_1%3a1.35-1_armhf.deb ... Feb 18 21:42:06 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:06.558Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:06 volumio volumio[1239]: info: Unpacking evtest (1:1.35-1) ... Feb 18 21:42:06 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:06.823Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:07 volumio volumio[1239]: info: Setting up evtest (1:1.35-1) ... Feb 18 21:42:07 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:07.482Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:07 volumio volumio[1239]: info: Setting up libevdev2:armhf (1.13.0+dfsg-1+rpi1) ... Feb 18 21:42:07 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:07.554Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:07 volumio volumio[1239]: info: Setting up libevemu3:armhf (2.7.0-3) ... Feb 18 21:42:07 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:07.604Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:07 volumio volumio[1239]: info: Setting up evemu-tools (2.7.0-3) ... Feb 18 21:42:07 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:07.834Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:07 volumio volumio[1239]: info: Processing triggers for libc-bin (2.36-9+rpt2+deb12u13) ... Feb 18 21:42:07 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:07.908Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:20 volumio sudo[5189]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:20 volumio sudo[5321]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /data/INTERNAL/Bluetooth_Remote Feb 18 21:42:20 volumio sudo[5321]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:27 volumio sudo[5321]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:27 volumio sudo[5324]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chown -R volumio /data/INTERNAL/Bluetooth_Remote Feb 18 21:42:27 volumio sudo[5324]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:27 volumio sudo[5324]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:27 volumio sudo[5326]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chgrp -R volumio /data/INTERNAL/Bluetooth_Remote Feb 18 21:42:27 volumio sudo[5326]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:27 volumio sudo[5326]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:27 volumio sudo[5328]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/chmod -R 777 /data/INTERNAL/Bluetooth_Remote Feb 18 21:42:27 volumio sudo[5328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:27 volumio sudo[5328]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:27 volumio sudo[5330]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /etc/systemd/system/triggerhappy.service.d Feb 18 21:42:27 volumio sudo[5330]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:27 volumio sudo[5330]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:27 volumio sudo[5332]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /etc/systemd/system/triggerhappy.service.d/override.conf Feb 18 21:42:27 volumio sudo[5332]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:27 volumio sudo[5332]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:27 volumio sudo[5334]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reexec Feb 18 21:42:27 volumio sudo[5334]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:27 volumio systemd[1]: Reexecuting. Feb 18 21:42:28 volumio systemd[1]: systemd 252.39-1~deb12u1+rpi1 running in system mode (+PAM +AUDIT +SELINUX +APPARMOR +IMA +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN +IPTC +KMOD +LIBCRYPTSETUP +LIBFDISK +PCRE2 -PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD -BPF_FRAMEWORK -XKBCOMMON +UTMP +SYSVINIT default-hierarchy=unified) Feb 18 21:42:28 volumio systemd[1]: Detected architecture arm. Feb 18 21:42:32 volumio sudo[5334]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:32 volumio sudo[5367]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload Feb 18 21:42:32 volumio sudo[5367]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:32 volumio systemd[1]: Reloading. Feb 18 21:42:36 volumio sudo[5367]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:36 volumio sudo[5387]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/systemctl restart triggerhappy Feb 18 21:42:36 volumio sudo[5387]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Feb 18 21:42:36 volumio systemd[1]: Starting apt-daily-upgrade.service - Daily apt upgrade and clean activities... Feb 18 21:42:36 volumio systemd[1]: Stopping triggerhappy.service - triggerhappy global hotkey daemon... Feb 18 21:42:36 volumio systemd[1]: triggerhappy.service: Deactivated successfully. Feb 18 21:42:36 volumio systemd[1]: Stopped triggerhappy.service - triggerhappy global hotkey daemon. Feb 18 21:42:36 volumio systemd[1]: Starting triggerhappy.service - triggerhappy global hotkey daemon... Feb 18 21:42:36 volumio systemd[1]: Started triggerhappy.service - triggerhappy global hotkey daemon. Feb 18 21:42:36 volumio sudo[5387]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:36 volumio sudo[4960]: pam_unix(sudo:session): session closed for user root Feb 18 21:42:36 volumio volumio[1239]: Plugin install end detected on script Feb 18 21:42:36 volumio volumio[1239]: info: Install script completed Feb 18 21:42:36 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:36.601Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:36 volumio volumio[1239]: info: Adding reference to registry Feb 18 21:42:36 volumio volumio5-onboarding[1653]: time=2026-02-18T18:42:36.623Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 18 21:42:36 volumio volumio[1239]: info: Done installing plugin. Feb 18 21:42:36 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 18 21:42:36 volumio volumio[1239]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 18 21:42:36 volumio volumio[1239]: info: Folder /tmp/plugins removed Feb 18 21:42:36 volumio volumio[1239]: info: Folder /tmp/downloaded_plugin.zip removed Feb 18 21:42:36 volumio volumio[1239]: info: Folder /data/temp removed Feb 18 21:42:38 volumio volumio[1239]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 21:42:38 volumio volumio[1239]: AggregateError Feb 18 21:42:38 volumio volumio[1239]: at internalConnectMultiple (node:net:1114:18) Feb 18 21:42:38 volumio volumio[1239]: at afterConnectMultiple (node:net:1667:5) { Feb 18 21:42:38 volumio volumio[1239]: code: 'ETIMEDOUT', Feb 18 21:42:38 volumio volumio[1239]: [errors]: [ Feb 18 21:42:38 volumio volumio[1239]: Error: connect ETIMEDOUT 23.73.2.88:443 Feb 18 21:42:38 volumio volumio[1239]: at createConnectionError (node:net:1634:14) Feb 18 21:42:38 volumio volumio[1239]: at Timeout.internalConnectMultipleTimeout (node:net:1685:38) Feb 18 21:42:38 volumio volumio[1239]: at listOnTimeout (node:internal/timers:575:11) Feb 18 21:42:38 volumio volumio[1239]: at process.processTimers (node:internal/timers:514:7) { Feb 18 21:42:38 volumio volumio[1239]: errno: -110, Feb 18 21:42:38 volumio volumio[1239]: code: 'ETIMEDOUT', Feb 18 21:42:38 volumio volumio[1239]: syscall: 'connect', Feb 18 21:42:38 volumio volumio[1239]: address: '23.73.2.88', Feb 18 21:42:38 volumio volumio[1239]: port: 443 Feb 18 21:42:38 volumio volumio[1239]: }, Feb 18 21:42:38 volumio volumio[1239]: Error: connect ETIMEDOUT 23.73.2.84:443 Feb 18 21:42:38 volumio volumio[1239]: at createConnectionError (node:net:1634:14) Feb 18 21:42:38 volumio volumio[1239]: at afterConnectMultiple (node:net:1664:40) { Feb 18 21:42:38 volumio volumio[1239]: errno: -110, Feb 18 21:42:38 volumio volumio[1239]: code: 'ETIMEDOUT', Feb 18 21:42:38 volumio volumio[1239]: syscall: 'connect', Feb 18 21:42:38 volumio volumio[1239]: address: '23.73.2.84', Feb 18 21:42:38 volumio volumio[1239]: port: 443 Feb 18 21:42:38 volumio volumio[1239]: } Feb 18 21:42:38 volumio volumio[1239]: ] Feb 18 21:42:38 volumio volumio[1239]: } Feb 18 21:42:38 volumio volumio[1239]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 18 21:42:40 volumio systemd[1]: apt-daily-upgrade.service: Deactivated successfully. Feb 18 21:42:40 volumio systemd[1]: Finished apt-daily-upgrade.service - Daily apt upgrade and clean activities. Feb 18 21:42:40 volumio systemd[1]: apt-daily-upgrade.service: Consumed 4.481s CPU time. Feb 18 21:42:41 volumio sudo[5476]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-18 21:41' Feb 18 21:42:41 volumio sudo[5476]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"