Oct 14 02:02:00 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:00 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:00 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:00 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:01 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:01 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:02 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:02 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:02 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:02 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:02 bass-bus systemd[1]: Stopping user@1000.service - User Manager for UID 1000... Oct 14 02:02:02 bass-bus systemd[3683]: Activating special unit exit.target... Oct 14 02:02:02 bass-bus systemd[3683]: Stopped target default.target - Main User Target. Oct 14 02:02:02 bass-bus systemd[3683]: Stopping mpris-proxy.service - Bluetooth mpris proxy... Oct 14 02:02:02 bass-bus mpris-proxy[3699]: org.bluez appeared Oct 14 02:02:02 bass-bus mpris-proxy[3699]: Bluetooth Adapter /org/bluez/hci0 found Oct 14 02:02:02 bass-bus mpris-proxy[3699]: Bluetooth Adapter /org/bluez/hci0 removed Oct 14 02:02:02 bass-bus mpris-proxy[3699]: org.bluez disappeared Oct 14 02:02:02 bass-bus systemd[3683]: Stopped mpris-proxy.service - Bluetooth mpris proxy. Oct 14 02:02:02 bass-bus systemd[3683]: Stopping dbus.service - D-Bus User Message Bus... Oct 14 02:02:02 bass-bus systemd[3683]: Stopped dbus.service - D-Bus User Message Bus. Oct 14 02:02:02 bass-bus systemd[3683]: Removed slice session.slice - User Core Session Slice. Oct 14 02:02:02 bass-bus systemd[3683]: Stopped target basic.target - Basic System. Oct 14 02:02:02 bass-bus systemd[3683]: Stopped target paths.target - Paths. Oct 14 02:02:02 bass-bus systemd[3683]: Stopped target sockets.target - Sockets. Oct 14 02:02:02 bass-bus systemd[3683]: Stopped target timers.target - Timers. Oct 14 02:02:02 bass-bus systemd[3683]: Closed dbus.socket - D-Bus User Message Bus Socket. Oct 14 02:02:02 bass-bus systemd[3683]: Closed dirmngr.socket - GnuPG network certificate management daemon. Oct 14 02:02:02 bass-bus systemd[3683]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 14 02:02:02 bass-bus systemd[3683]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Oct 14 02:02:02 bass-bus systemd[3683]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Oct 14 02:02:02 bass-bus systemd[3683]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Oct 14 02:02:02 bass-bus systemd[3683]: Removed slice app.slice - User Application Slice. Oct 14 02:02:02 bass-bus systemd[3683]: Reached target shutdown.target - Shutdown. Oct 14 02:02:02 bass-bus systemd[3683]: Finished systemd-exit.service - Exit the Session. Oct 14 02:02:02 bass-bus systemd[3683]: Reached target exit.target - Exit the Session. Oct 14 02:02:02 bass-bus systemd[1]: user@1000.service: Deactivated successfully. Oct 14 02:02:02 bass-bus systemd[1]: Stopped user@1000.service - User Manager for UID 1000. Oct 14 02:02:02 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:02 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:02 bass-bus systemd[1]: Stopping user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Oct 14 02:02:02 bass-bus systemd[1]: run-user-1000.mount: Deactivated successfully. Oct 14 02:02:02 bass-bus systemd[1]: user-runtime-dir@1000.service: Deactivated successfully. Oct 14 02:02:02 bass-bus systemd[1]: Stopped user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Oct 14 02:02:02 bass-bus systemd[1]: Removed slice user-1000.slice - User Slice of UID 1000. Oct 14 02:02:02 bass-bus systemd[1]: user-1000.slice: Consumed 14.808s CPU time. Oct 14 02:02:03 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:03 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:03 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:03 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:04 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:04 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:04 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:04 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:05 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:05 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:05 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:05 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:06 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:06 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:06 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:06 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:07 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:07 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:07 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:07 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:08 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:08 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:08 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:08 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:09 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:09 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:09 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:09 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:10 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:10 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:10 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:10 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:10 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:10 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:11 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:11 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:12 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:12 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:12 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:12 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:13 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:13 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:13 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:13 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:14 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:14 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:14 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:14 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:15 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:15 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:15 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:15 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:16 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:16 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:16 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:16 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:16 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:16 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:17 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:17 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:17 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:17 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:18 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:18 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:18 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:18 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:19 bass-bus python3[1576]: 2026-10-14 02:02:19,016 volumio_client WARNING Socket.io error: Connection error — retrying REST fallback Oct 14 02:02:19 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:19 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:19 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:19 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:20 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:20 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:20 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:20 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:21 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:21 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:22 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:22 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:22 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:22 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:23 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:23 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:23 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:23 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:24 bass-bus python3[1576]: 2026-10-14 02:02:24,062 volumio_client INFO Reconnecting in 30s... Oct 14 02:02:24 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:24 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:24 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:24 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:24 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:24 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:25 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:25 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:25 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:25 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:26 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:26 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:26 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:26 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:27 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:27 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:27 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:27 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:28 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:28 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:28 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:28 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:29 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:29 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:29 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:29 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:30 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:30 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:30 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:30 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:31 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:31 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:32 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:32 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:32 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:32 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:32 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:32 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:33 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:33 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:33 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:33 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:34 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:34 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:34 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:34 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:35 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:35 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:35 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:35 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:36 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:36 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:36 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:36 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:37 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:37 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:37 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:37 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:38 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:38 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:38 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:38 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:39 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:39 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:39 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:39 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:40 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:40 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:40 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:40 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:40 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:40 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:41 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:41 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:42 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:42 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:42 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:42 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:43 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:43 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:43 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:43 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:44 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:44 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:44 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:44 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:45 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:45 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:45 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:45 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:46 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:46 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:46 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:46 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:47 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:47 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:47 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:47 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:48 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:48 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:48 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:48 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:48 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:48 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:49 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:49 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:49 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:49 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:50 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:50 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:50 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:50 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:51 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:51 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:51 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:51 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:52 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:52 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:53 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:53 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:53 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:53 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:54 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:54 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:54 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:54 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:55 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:55 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:55 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:55 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:56 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:56 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:56 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:56 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:56 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:56 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:57 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:57 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:57 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:57 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:58 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:58 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:58 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:58 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:59 bass-bus python3[1576]: 2026-10-14 02:02:59,109 volumio_client WARNING Socket.io error: Connection error — retrying REST fallback Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:59 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:59 bass-bus volumio[1574]: info: Received Get System Version Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 02:02:59 bass-bus volumio[1574]: info: Received Get System Info Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 02:02:59 bass-bus volumio[1574]: info: Discovery: Getting this device information Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:59 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 02:02:59 bass-bus volumio[1574]: info: Received Get System Info Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 14 02:02:59 bass-bus volumio[1574]: info: Discovery: Getting this device information Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:59 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 14 02:02:59 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:02:59 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:00 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:00 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:00 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:00 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:01 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:01 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:01 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:01 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:02 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:02 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:03 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:03 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:03 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:03 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:04 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:04 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:04 bass-bus python3[1576]: 2026-10-14 02:03:04,152 volumio_client INFO Reconnecting in 30s... Oct 14 02:03:04 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:04 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:05 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:05 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:05 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:05 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:06 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:06 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:06 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:06 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:06 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:06 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:07 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:07 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:07 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:07 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:08 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:08 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:08 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:08 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:09 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:09 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:09 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:09 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:10 bass-bus volumio[1574]: info: CoreCommandRouter::Close All Modals sent Oct 14 02:03:10 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:10 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:10 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:10 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:11 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:11 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:11 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:11 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:12 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:12 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:13 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:13 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:13 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:13 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:14 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:14 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:14 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:14 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:15 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:15 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:15 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:15 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:16 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:16 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:16 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:16 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:16 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:16 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:17 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:17 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:17 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:17 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:18 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:18 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:18 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:18 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:19 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:19 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:19 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:19 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:20 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:20 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:20 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:20 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:21 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:21 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:21 bass-bus volumio[1574]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/soloist_connect/volumio/bookworm/armhf Oct 14 02:03:21 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:21.512+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:21 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:21 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:22 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:22 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:22 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:22 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:23 bass-bus volumio[1574]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/soloist_connect/volumio/bookworm/armhf Oct 14 02:03:23 bass-bus volumio[1574]: info: Folder /tmp/plugins removed Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.122+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.237+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio[1574]: info: Check plugin dependencies Oct 14 02:03:23 bass-bus volumio[1574]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.282+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio[1574]: info: Checking if plugin already exists Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.292+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio[1574]: info: Rename folder Oct 14 02:03:23 bass-bus volumio[1574]: info: Folder /tmp/downloaded_plugin.zip removed Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.330+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio[1574]: info: Move to category Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.688+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio[1574]: info: Checking if install.sh is present Oct 14 02:03:23 bass-bus volumio[1574]: info: Executing install.sh Oct 14 02:03:23 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:23 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:23 bass-bus sudo[3919]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/music_service/soloist_connect/install.sh Oct 14 02:03:23 bass-bus sudo[3919]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Oct 14 02:03:23 bass-bus volumio[1574]: info: Installing Spotify Soloist Connect (Volumio 4 ALSA)... Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.743+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio[1574]: info: Detected userspace armhf (uname=armv7l) Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.798+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:23 bass-bus volumio[1574]: info: Installing patchelf... Oct 14 02:03:23 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:23.813+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:24 bass-bus volumio[1574]: info: Get:1 http://deb.debian.org/debian bookworm-backports InRelease [59.4 kB] Oct 14 02:03:24 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:24.189+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:24 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:24 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:24 bass-bus volumio[1574]: info: Get:2 http://archive.raspberrypi.com/debian bookworm InRelease [54.9 kB] Oct 14 02:03:24 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:24.253+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:24 bass-bus volumio[1574]: info: Hit:3 http://archive.raspbian.org/raspbian bookworm InRelease Oct 14 02:03:24 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:24.323+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:24 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:24 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:24 bass-bus volumio[1574]: info: Get:4 http://archive.raspberrypi.com/debian bookworm/main armhf Packages [587 kB] Oct 14 02:03:24 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:24.929+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:25 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:25 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:25 bass-bus volumio[1574]: info: Fetched 701 kB in 1s (485 kB/s) Oct 14 02:03:25 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:25.442+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:25 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:25 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:26 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:26 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:26 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:26 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:27 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:27 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:27 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:27 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:28 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:28 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:28 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:28 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:29 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:29 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:29 bass-bus volumio[1574]: info: Reading package lists... Oct 14 02:03:29 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:29.691+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:30 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:30 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:30 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:30 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:30 bass-bus volumio[1574]: info: Reading package lists... Oct 14 02:03:30 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:30.592+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:31 bass-bus volumio[1574]: info: Building dependency tree... Oct 14 02:03:31 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:31.103+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:31 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:31 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:31 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:31 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:31 bass-bus volumio[1574]: info: Reading state information... Oct 14 02:03:31 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:31.786+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:32 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:32 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:32 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:32 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:32 bass-bus volumio[1574]: info: The following NEW packages will be installed: Oct 14 02:03:32 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:32.811+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:32 bass-bus volumio[1574]: info: patchelf Oct 14 02:03:32 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:32.845+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:33 bass-bus volumio[1574]: info: 0 upgraded, 1 newly installed, 0 to remove and 4 not upgraded. Oct 14 02:03:33 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:33.014+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:33 bass-bus volumio[1574]: info: Need to get 59.8 kB of archives. Oct 14 02:03:33 bass-bus volumio[1574]: info: After this operation, 173 kB of additional disk space will be used. Oct 14 02:03:33 bass-bus volumio[1574]: info: Get:1 http://archive.raspbian.org/raspbian bookworm/main armhf patchelf armhf 0.14.3-1 [59.8 kB] Oct 14 02:03:33 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:33.025+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:33 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:33.025+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:33 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:33.031+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:33 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:33 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:33 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:33 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:34 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:34 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:34 bass-bus volumio[1574]: info: Fetched 59.8 kB in 0s (250 kB/s) Oct 14 02:03:34 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:34.567+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:34 bass-bus volumio[1574]: info: Selecting previously unselected package patchelf. Oct 14 02:03:34 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:34.658+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:34 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:34 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:35 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:35 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:35 bass-bus volumio[1574]: [620B blob data] Oct 14 02:03:35 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:35.719+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:35 bass-bus volumio[1574]: info: Preparing to unpack .../patchelf_0.14.3-1_armhf.deb ... Oct 14 02:03:35 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:35.741+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:35 bass-bus volumio[1574]: info: Unpacking patchelf (0.14.3-1) ... Oct 14 02:03:35 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:35.770+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:35 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:35 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:36 bass-bus volumio[1574]: info: Setting up patchelf (0.14.3-1) ... Oct 14 02:03:36 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:36.047+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:36 bass-bus volumio[1574]: info: Processing triggers for man-db (2.11.2-2) ... Oct 14 02:03:36 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:36.097+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:36 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:36 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:36 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:36 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:37 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:37 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:37 bass-bus systemd[1]: Reloading. Oct 14 02:03:37 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:37 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:38 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:38 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:38 bass-bus systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:38 bass-bus systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:38 bass-bus systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:38 bass-bus systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:38 bass-bus systemd[1]: Reloading. Oct 14 02:03:39 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:39 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:39 bass-bus python3[1576]: 2026-10-14 02:03:39,195 volumio_client WARNING Socket.io error: Connection error — retrying REST fallback Oct 14 02:03:39 bass-bus systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:39 bass-bus systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:39 bass-bus systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:39 bass-bus systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Oct 14 02:03:39 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:39 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:39 bass-bus volumio[1574]: info: /etc/sudoers.d/volumio-user-soloist_connect: parsed OK Oct 14 02:03:39 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:39.635+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:39 bass-bus volumio[1574]: info: Downloading Spotify Soloist for userspace armhf (uname=armv7l dpkg=armhf bits=32) ... Oct 14 02:03:39 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:39.704+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:40 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:40 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:40 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:40 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:41 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:41 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:41 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:41 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:42 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:42 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:42 bass-bus volumio[1574]: info: System glibc is 2.36; sideloading armhf glibc from Debian trixie... Oct 14 02:03:42 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:42.459+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:42 bass-bus volumio[1574]: info: Fetching trixie package index for armhf... Oct 14 02:03:42 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:42.504+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:42 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:42 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:43 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:43 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:43 bass-bus volumio[1574]: info: Downloading libc6 ... Oct 14 02:03:43 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:43.636+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:43 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:43 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:44 bass-bus python3[1576]: 2026-10-14 02:03:44,235 volumio_client INFO Reconnecting in 30s... Oct 14 02:03:44 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:44 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:44 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:44 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:45 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:45 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:45 bass-bus volumio[1574]: info: Downloading libgcc-s1 ... Oct 14 02:03:45 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:45.498+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:45 bass-bus volumio[1574]: info: Downloading libstdc++6 ... Oct 14 02:03:45 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:45.854+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:45 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:45 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:46 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:46 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:46 bass-bus volumio[1574]: info: Downloading libatomic1 ... Oct 14 02:03:46 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:46.542+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:46 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:46 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:47 bass-bus volumio[1574]: info: patch-soloist: patched /data/soloist/staging/soloist Oct 14 02:03:47 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:47.081+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:47 bass-bus volumio[1574]: info: interpreter: /data/soloist/sysroot/usr/lib/arm-linux-gnueabihf/ld-linux-armhf.so.3 Oct 14 02:03:47 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:47.199+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:47 bass-bus volumio[1574]: 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 14 02:03:47 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:47.324+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:47 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:47 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:47 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:47 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:48 bass-bus volumio[1574]: info: Sideload complete. Test with: /data/soloist/staging/soloist --version Oct 14 02:03:48 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:48.502+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:48 bass-bus volumio[1574]: info: CoreCommandRouter::volumioGetState Oct 14 02:03:48 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:48 bass-bus volumio[1574]: info: Patched interpreter: /data/soloist/sysroot/usr/lib/arm-linux-gnueabihf/ld-linux-armhf.so.3 Oct 14 02:03:48 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:48.625+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:48 bass-bus volumio[1574]: info: Staged: soloist 1.3.9.20 build 1791914499 (20261013) (g440165f200) (linux/arm) Oct 14 02:03:48 bass-bus volumio5-onboarding[2172]: time=2026-10-14T02:03:48.677+02:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state Oct 14 02:03:48 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 19 Oct 14 02:03:48 bass-bus volumio[1574]: info: CorePlayQueue::getTrack 17 Oct 14 02:03:48 bass-bus volumio[1574]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 02:03:48 bass-bus volumio[1574]: TypeError: Cannot read properties of undefined (reading 'service') Oct 14 02:03:48 bass-bus volumio[1574]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:458:107) Oct 14 02:03:48 bass-bus volumio[1574]: at listOnTimeout (node:internal/timers:573:17) Oct 14 02:03:48 bass-bus volumio[1574]: at process.processTimers (node:internal/timers:514:7) Oct 14 02:03:48 bass-bus volumio[1574]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 02:03:49 bass-bus sudo[4404]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 02:02' Oct 14 02:03:49 bass-bus sudo[4404]: 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="49c3b8c3d90722cb303dcca504ebce2ff3c7ebdf" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4bdfbfc68c4d22128e9bac172462cbd14ece0c88" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Oct 12 13:56:12 UTC 2026" VOLUMIO_VERSION="4.231" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="43f53a1f9ad8f3b898137f70f5cd23ce"