Mar 29 11:01:02 volumio volumio-remote-updater[715]: [2026-03-29 11:01:02] [connect] Successful connection
Mar 29 11:01:17 volumio volumio-remote-updater[715]: [2026-03-29 11:01:17] [connect] Successful connection
Mar 29 11:01:23 volumio volumio5-onboarding[1411]: time=2026-03-29T11:01:23.230+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:01:23 volumio volumio[1125]: info: Checking if install.sh is present
Mar 29 11:01:23 volumio volumio5-onboarding[1411]: time=2026-03-29T11:01:23.255+01:00 level=ERROR msg="failed reading message" error="websocket: close 1000 (normal)"
Mar 29 11:01:23 volumio volumio[1125]: info: Executing install.sh
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7
Mar 29 11:01:23 volumio sudo[4449]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/now_playing/install.sh
Mar 29 11:01:23 volumio sudo[4449]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8
Mar 29 11:01:23 volumio volumio[1125]: info: Installing geo-tz node dependency
Mar 29 11:01:23 volumio su[4452]: (to volumio) root on none
Mar 29 11:01:23 volumio su[4452]: pam_unix(su:session): session opened for user volumio(uid=1000) by (uid=0)
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio systemd[1]: Created slice user-1000.slice - User Slice of UID 1000.
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio systemd[1]: Starting user-runtime-dir@1000.service - User Runtime Directory /run/user/1000...
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio systemd[1]: Finished user-runtime-dir@1000.service - User Runtime Directory /run/user/1000.
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio systemd[1]: Starting user@1000.service - User Manager for UID 1000...
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio (systemd)[4454]: pam_unix(systemd-user:session): session opened for user volumio(uid=1000) by (uid=0)
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:23 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 9
Mar 29 11:01:24 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Mar 29 11:01:24 volumio volumio[1125]: verbose: New Socket.io Connection to 192.168.0.127 from 192.168.0.66 UA: Mozilla/5.0 (Linux; Android 15; 2311DRK48G Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/146.0.7680.119 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState
Mar 29 11:01:24 volumio volumio[1125]: info: CorePlayQueue::getTrack 0
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Mar 29 11:01:24 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 12
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::volumioGetVisibleSources
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState
Mar 29 11:01:24 volumio volumio[1125]: info: CorePlayQueue::getTrack 0
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Mar 29 11:01:24 volumio volumio[1125]: info: Received Get System Info
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Mar 29 11:01:24 volumio volumio[1125]: info: Discovery: Getting this device information
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState
Mar 29 11:01:24 volumio volumio[1125]: info: CorePlayQueue::getTrack 0
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState
Mar 29 11:01:24 volumio volumio[1125]: info: CorePlayQueue::getTrack 0
Mar 29 11:01:24 volumio volumio[1125]: info: Listing playlists
Mar 29 11:01:24 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13
Mar 29 11:01:24 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState
Mar 29 11:01:24 volumio volumio[1125]: info: CorePlayQueue::getTrack 0
Mar 29 11:01:24 volumio volumio[1125]: SPOTIFY: RECEIVED VOLUMIO VOLUME 86
Mar 29 11:01:24 volumio systemd[4454]: Queued start job for default target default.target.
Mar 29 11:01:24 volumio systemd[4454]: Created slice app.slice - User Application Slice.
Mar 29 11:01:24 volumio systemd[4454]: Reached target paths.target - Paths.
Mar 29 11:01:24 volumio systemd[4454]: Reached target timers.target - Timers.
Mar 29 11:01:24 volumio systemd[4454]: Listening on dirmngr.socket - GnuPG network certificate management daemon.
Mar 29 11:01:24 volumio systemd[4454]: Listening on gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers).
Mar 29 11:01:24 volumio systemd[4454]: Listening on gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted).
Mar 29 11:01:24 volumio systemd[4454]: Listening on gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation).
Mar 29 11:01:24 volumio systemd[4454]: Listening on gpg-agent.socket - GnuPG cryptographic agent and passphrase cache.
Mar 29 11:01:24 volumio systemd[4454]: Reached target sockets.target - Sockets.
Mar 29 11:01:24 volumio systemd[4454]: Reached target basic.target - Basic System.
Mar 29 11:01:24 volumio systemd[1]: Started user@1000.service - User Manager for UID 1000.
Mar 29 11:01:24 volumio systemd[4454]: Started mpris-proxy.service - Bluetooth mpris proxy.
Mar 29 11:01:24 volumio systemd[4454]: Reached target default.target - Main User Target.
Mar 29 11:01:24 volumio systemd[4454]: Startup finished in 883ms.
Mar 29 11:01:24 volumio systemd[1]: Started session-c1.scope - Session c1 of User volumio.
Mar 29 11:01:24 volumio mpris-proxy[4470]: Can't get on session bus
Mar 29 11:01:24 volumio systemd[4454]: mpris-proxy.service: Main process exited, code=exited, status=1/FAILURE
Mar 29 11:01:24 volumio systemd[4454]: mpris-proxy.service: Failed with result 'exit-code'.
Mar 29 11:01:31 volumio ntpd[888]: PROTO: 185.228.163.139 unlink local addr 192.168.0.127 ->
Mar 29 11:01:32 volumio volumio-remote-updater[715]: [2026-03-29 11:01:32] [connect] Successful connection
Mar 29 11:01:32 volumio volumio-remote-updater[715]: [2026-03-29 11:01:32] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1774778492 101
Mar 29 11:01:33 volumio volumio[1125]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 14
Mar 29 11:02:42 volumio volumio[1125]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf
Mar 29 11:02:42 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:42.065+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio[1125]: info:
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.565+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio[1125]: info: added 27 packages, changed 4 packages, and audited 162 packages in 1m
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.577+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio[1125]: info:
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.599+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio[1125]: info: 24 packages are looking for funding
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.618+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio[1125]: info: run `npm fund` for details
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.642+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio[1125]: info:
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.672+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio[1125]: info: 5 vulnerabilities (1 low, 1 moderate, 3 high)
Mar 29 11:02:47 volumio volumio[1125]: info:
Mar 29 11:02:47 volumio volumio[1125]: info: To address all issues, run:
Mar 29 11:02:47 volumio volumio[1125]: info: npm audit fix
Mar 29 11:02:47 volumio volumio[1125]: info:
Mar 29 11:02:47 volumio volumio[1125]: info: Run `npm audit` for details.
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.685+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.686+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.687+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.688+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.689+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:47.690+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:47 volumio su[4452]: pam_unix(su:session): session closed for user volumio
Mar 29 11:02:47 volumio systemd[1]: Starting systemd-tmpfiles-clean.service - Cleanup of Temporary Directories...
Mar 29 11:02:48 volumio volumio[1125]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/now_playing/volumio/bookworm/armhf
Mar 29 11:02:48 volumio volumio[1125]: info: Folder /tmp/plugins removed
Mar 29 11:02:49 volumio volumio[1125]: info: Creating user directories (if not exist)
Mar 29 11:02:49 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:49.882+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:49 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:49.992+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:50 volumio systemd[1]: session-c1.scope: Deactivated successfully.
Mar 29 11:02:50 volumio systemd[1]: session-c1.scope: Consumed 48.357s CPU time.
Mar 29 11:02:51 volumio sudo[4449]: pam_unix(sudo:session): session closed for user root
Mar 29 11:02:51 volumio volumio[1125]: info: Now Playing plugin installed
Mar 29 11:02:51 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:51.136+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:51 volumio volumio[1125]: Plugin install end detected on script
Mar 29 11:02:51 volumio volumio[1125]: info: Install script completed
Mar 29 11:02:51 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:51.157+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:51 volumio volumio[1125]: info: Adding reference to registry
Mar 29 11:02:51 volumio volumio5-onboarding[1411]: time=2026-03-29T11:02:51.172+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Mar 29 11:02:51 volumio volumio[1125]: info: Done installing plugin.
Mar 29 11:02:51 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Mar 29 11:02:51 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Mar 29 11:02:51 volumio volumio[1125]: info: Folder /tmp/plugins removed
Mar 29 11:02:51 volumio volumio[1125]: info: Folder /tmp/downloaded_plugin.zip removed
Mar 29 11:02:51 volumio systemd[1]: systemd-tmpfiles-clean.service: Deactivated successfully.
Mar 29 11:02:51 volumio systemd[1]: Finished systemd-tmpfiles-clean.service - Cleanup of Temporary Directories.
Mar 29 11:02:51 volumio systemd[1]: run-credentials-systemd\x2dtmpfiles\x2dclean.service.mount: Deactivated successfully.
Mar 29 11:02:51 volumio volumio[1125]: info: Folder /data/temp removed
Mar 29 11:02:51 volumio volumio[1125]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 29 11:02:51 volumio volumio[1125]: Error: Unable to resolve or reject the same promise twice
Mar 29 11:02:51 volumio volumio[1125]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Mar 29 11:02:51 volumio volumio[1125]: at /volumio/app/pluginmanager.js:1087:11
Mar 29 11:02:51 volumio volumio[1125]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Mar 29 11:02:51 volumio volumio[1125]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24
Mar 29 11:02:51 volumio volumio[1125]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Mar 29 11:02:51 volumio volumio[1125]: at /volumio/node_modules/fs-extra/lib/remove/rimraf.js:213:24
Mar 29 11:02:51 volumio volumio[1125]: at CB (/volumio/node_modules/fs-extra/lib/remove/rimraf.js:57:5)
Mar 29 11:02:51 volumio volumio[1125]: at FSReqCallback.oncomplete (node:fs:190:23)
Mar 29 11:02:51 volumio volumio[1125]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 29 11:02:52 volumio sudo[4629]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-29 11:01'
Mar 29 11:02:52 volumio sudo[4629]: 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"