Aug 25 22:40:17 volumio sshd[4687]: Received disconnect from 192.168.4.37 port 60414:11: Aug 25 22:40:17 volumio sshd[4687]: Disconnected from user volumio 192.168.4.37 port 60414 Aug 25 22:40:17 volumio sshd[4684]: Received disconnect from 192.168.4.37 port 60416:11: Aug 25 22:40:17 volumio sshd[4684]: Disconnected from user volumio 192.168.4.37 port 60416 Aug 25 22:40:17 volumio sshd[4479]: Received disconnect from 192.168.4.37 port 33444:11: Aug 25 22:40:17 volumio sshd[4479]: Disconnected from user volumio 192.168.4.37 port 33444 Aug 25 22:40:17 volumio sshd[4664]: pam_unix(sshd:session): session closed for user volumio Aug 25 22:40:17 volumio sshd[4665]: pam_unix(sshd:session): session closed for user volumio Aug 25 22:40:17 volumio sshd[4445]: pam_unix(sshd:session): session closed for user volumio Aug 25 22:40:17 volumio systemd[1]: session-4.scope: Deactivated successfully. Aug 25 22:40:17 volumio systemd[1]: session-4.scope: Consumed 10min 11.854s CPU time. Aug 25 22:40:17 volumio systemd[1]: session-1.scope: Deactivated successfully. Aug 25 22:40:17 volumio systemd[1]: session-3.scope: Deactivated successfully. Aug 25 22:40:17 volumio systemd[1]: session-3.scope: Consumed 10min 17.194s CPU time. Aug 25 22:40:17 volumio systemd-logind[856]: Session 4 logged out. Waiting for processes to exit. Aug 25 22:40:17 volumio systemd-logind[856]: Session 1 logged out. Waiting for processes to exit. Aug 25 22:40:17 volumio systemd-logind[856]: Session 3 logged out. Waiting for processes to exit. Aug 25 22:40:17 volumio systemd-logind[856]: Removed session 4. Aug 25 22:40:17 volumio systemd-logind[856]: Removed session 1. Aug 25 22:40:17 volumio systemd-logind[856]: Removed session 3. Aug 25 22:40:27 volumio systemd[1]: Stopping user@1000.service - User Manager for UID 1000... Aug 25 22:40:28 volumio systemd[4452]: Activating special unit exit.target... Aug 25 22:40:28 volumio systemd[4452]: Stopped target default.target - Main User Target. Aug 25 22:40:28 volumio systemd[4452]: Stopping mpris-proxy.service - Bluetooth mpris proxy... Aug 25 22:40:28 volumio mpris-proxy[4468]: org.bluez appeared Aug 25 22:40:28 volumio mpris-proxy[4468]: org.bluez disappeared Aug 25 22:40:28 volumio systemd[4452]: Stopped mpris-proxy.service - Bluetooth mpris proxy. Aug 25 22:40:28 volumio systemd[4452]: Stopping dbus.service - D-Bus User Message Bus... Aug 25 22:40:28 volumio systemd[4452]: Stopped dbus.service - D-Bus User Message Bus. Aug 25 22:40:28 volumio systemd[4452]: Removed slice session.slice - User Core Session Slice. Aug 25 22:40:28 volumio systemd[4452]: Stopped target basic.target - Basic System. Aug 25 22:40:28 volumio systemd[4452]: Stopped target paths.target - Paths. Aug 25 22:40:28 volumio systemd[4452]: Stopped target sockets.target - Sockets. Aug 25 22:40:28 volumio systemd[4452]: Stopped target timers.target - Timers. Aug 25 22:40:28 volumio systemd[4452]: Closed dbus.socket - D-Bus User Message Bus Socket. Aug 25 22:40:28 volumio systemd[4452]: Closed dirmngr.socket - GnuPG network certificate management daemon. Aug 25 22:40:28 volumio systemd[4452]: Closed gpg-agent-browser.socket - GnuPG cryptographic agent and passphrase cache (access for web browsers). Aug 25 22:40:28 volumio systemd[4452]: Closed gpg-agent-extra.socket - GnuPG cryptographic agent and passphrase cache (restricted). Aug 25 22:40:28 volumio systemd[4452]: Closed gpg-agent-ssh.socket - GnuPG cryptographic agent (ssh-agent emulation). Aug 25 22:40:28 volumio systemd[4452]: Closed gpg-agent.socket - GnuPG cryptographic agent and passphrase cache. Aug 25 22:40:28 volumio systemd[4452]: Removed slice app.slice - User Application Slice. Aug 25 22:40:28 volumio systemd[4452]: Reached target shutdown.target - Shutdown. Aug 25 22:40:28 volumio systemd[4452]: Finished systemd-exit.service - Exit the Session. Aug 25 22:40:28 volumio systemd[4452]: Reached target exit.target - Exit the Session. Aug 25 22:40:28 volumio systemd[1]: user@1000.service: Deactivated successfully. Aug 25 22:40:28 volumio systemd[1]: Stopped user@1000.service - User Manager for UID 1000. Aug 25 22:40:28 volumio systemd[1]: Stopping user-runtime-dir@1000.service - User Runtime Directory /run/user/1000... Aug 25 22:40:28 volumio systemd[1]: run-user-1000.mount: Deactivated successfully. Aug 25 22:40:28 volumio systemd[1]: user-runtime-dir@1000.service: Deactivated successfully. Aug 25 22:40:28 volumio systemd[1]: Stopped user-runtime-dir@1000.service - User Runtime Directory /run/user/1000. Aug 25 22:40:28 volumio systemd[1]: Removed slice user-1000.slice - User Slice of UID 1000. Aug 25 22:40:28 volumio systemd[1]: user-1000.slice: Consumed 20min 29.178s CPU time. Aug 25 22:40:30 volumio ntpd[1059]: PROTO: 166.88.142.52 unlink local addr 192.168.4.41 -> Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 22:40:35 volumio volumio[1131]: info: Retrieving Cloud Streaming UI Aug 25 22:40:35 volumio volumio[1131]: info: Getting Tidal Cloud Configuration Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 22:40:35 volumio volumio[1131]: info: Getting Qobuz Cloud Configuration Aug 25 22:40:35 volumio volumio[1131]: info: Asking plugin for UI Config Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 22:40:35 volumio volumio[1131]: info: Getting Spotify Cloud Configuration Aug 25 22:40:35 volumio volumio[1131]: info: Asking plugin for UI Config Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 22:40:35 volumio volumio[1131]: info: Saving Spotify Acccount Aug 25 22:40:35 volumio volumio[1131]: info: Got Tidal Cloud Configuration Aug 25 22:40:35 volumio volumio[1131]: info: Got it Aug 25 22:40:35 volumio volumio[1131]: info: Got it Aug 25 22:40:35 volumio volumio[1131]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 25 22:40:35 volumio volumio[1131]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::volumioGetBrowseSources Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:40:35 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 25 22:40:37 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Aug 25 22:40:37 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand update Aug 25 22:40:37 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:40:37 volumio volumio[1131]: info: Aug 25 22:40:37 volumio volumio[1131]: ---------------------------- MPD announces state update: update Aug 25 22:40:37 volumio volumio[1131]: info: sendMpdCommand update took 1 milliseconds Aug 25 22:40:37 volumio volumio[1131]: info: ControllerMpd::getState Aug 25 22:40:37 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:40:37 volumio volumio[1131]: info: sendMpdCommand status took 107 milliseconds Aug 25 22:40:37 volumio volumio[1131]: info: sendMpdCommand status took 107 milliseconds Aug 25 22:40:37 volumio volumio[1131]: verbose: ControllerMpd::parseState Aug 25 22:40:37 volumio volumio[1131]: info: Command Router : Notfying DB Updatetrue Aug 25 22:40:37 volumio volumio[1131]: verbose: ControllerMpd::parseState Aug 25 22:40:37 volumio volumio[1131]: info: ControllerMpd::pushState Aug 25 22:40:37 volumio volumio[1131]: info: CoreCommandRouter::servicePushState Aug 25 22:40:37 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:37 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:37 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:37 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:37 volumio volumio[1131]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 25 22:40:37 volumio volumio[1131]: verbose: CURRENT POSITION 0 Aug 25 22:40:37 volumio volumio[1131]: info: CoreStateMachine::syncState stateService stop Aug 25 22:40:37 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus stop Aug 25 22:40:37 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:37 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:37 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:40:37 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:37 volumio volumio[1131]: info: No code Aug 25 22:40:37 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:37 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:37 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:37 volumio volumio[1131]: info: ------------------------------ 136ms Aug 25 22:40:39 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:40:41 volumio volumio[1131]: info: CoreCommandRouter::Close All Modals sent Aug 25 22:40:43 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:40:47 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:40:49 volumio volumio[1131]: info: MPD Database updated - AlbumList cache refreshed Aug 25 22:40:49 volumio volumio[1131]: info: Aug 25 22:40:49 volumio volumio[1131]: ---------------------------- MPD announces state update: database Aug 25 22:40:49 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:40:49 volumio volumio[1131]: info: Aug 25 22:40:49 volumio volumio[1131]: ---------------------------- MPD announces state update: update Aug 25 22:40:49 volumio volumio[1131]: info: ControllerMpd::getState Aug 25 22:40:49 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:40:49 volumio volumio[1131]: info: ControllerMpd::getState Aug 25 22:40:49 volumio volumio[1131]: verbose: ControllerMpd::sendMpdCommand status Aug 25 22:40:49 volumio volumio[1131]: info: sendMpdCommand status took 147 milliseconds Aug 25 22:40:49 volumio volumio[1131]: info: sendMpdCommand status took 147 milliseconds Aug 25 22:40:49 volumio volumio[1131]: info: sendMpdCommand status took 147 milliseconds Aug 25 22:40:49 volumio volumio[1131]: verbose: ControllerMpd::parseState Aug 25 22:40:49 volumio volumio[1131]: info: Command Router : Notfying DB Updatefalse Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::Close All Modals sent Aug 25 22:40:49 volumio volumio[1131]: verbose: ControllerMpd::parseState Aug 25 22:40:49 volumio volumio[1131]: verbose: ControllerMpd::parseState Aug 25 22:40:49 volumio volumio[1131]: info: ControllerMpd::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::servicePushState Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 25 22:40:49 volumio volumio[1131]: verbose: CURRENT POSITION 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::syncState stateService stop Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus stop Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:49 volumio volumio[1131]: info: No code Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:49 volumio volumio[1131]: info: ControllerMpd::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::servicePushState Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 25 22:40:49 volumio volumio[1131]: verbose: CURRENT POSITION 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::syncState stateService stop Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::syncState currentStatus stop Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:49 volumio volumio[1131]: info: No code Aug 25 22:40:49 volumio volumio[1131]: info: CoreStateMachine::pushState Aug 25 22:40:49 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:40:49 volumio volumio[1131]: info: CoreCommandRouter::volumioPushState Aug 25 22:40:49 volumio volumio[1131]: info: ------------------------------ 171ms Aug 25 22:40:49 volumio volumio[1131]: info: ------------------------------ 172ms Aug 25 22:40:51 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:40:55 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:40:59 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:41:03 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:41:07 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:41:11 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:41:15 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 25 22:41:19 volumio volumio[1131]: info: CoreCommandRouter::volumioGetState Aug 25 22:41:19 volumio volumio[1131]: info: CorePlayQueue::getTrack 0 Aug 25 22:41:22 volumio volumio[1131]: info: CoreCommandRouter::volumioGetQueue Aug 25 22:41:22 volumio volumio[1131]: info: CoreStateMachine::getQueue Aug 25 22:41:22 volumio volumio[1131]: info: CorePlayQueue::getQueue Aug 25 22:41:24 volumio volumio[1131]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 25 22:41:24 volumio volumio[1131]: info: CURURI: artists:// Aug 25 22:41:24 volumio volumio[1131]: info: Preload queue cleared Aug 25 22:41:25 volumio volumio[1131]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 22:41:25 volumio volumio[1131]: AggregateError Aug 25 22:41:25 volumio volumio[1131]: at internalConnectMultiple (node:net:1114:18) Aug 25 22:41:25 volumio volumio[1131]: at afterConnectMultiple (node:net:1667:5) { Aug 25 22:41:25 volumio volumio[1131]: code: 'ECONNREFUSED', Aug 25 22:41:25 volumio volumio[1131]: [errors]: [ Aug 25 22:41:25 volumio volumio[1131]: Error: connect ECONNREFUSED 158.69.210.98:443 Aug 25 22:41:25 volumio volumio[1131]: at createConnectionError (node:net:1634:14) Aug 25 22:41:25 volumio volumio[1131]: at afterConnectMultiple (node:net:1664:40) { Aug 25 22:41:25 volumio volumio[1131]: errno: -111, Aug 25 22:41:25 volumio volumio[1131]: code: 'ECONNREFUSED', Aug 25 22:41:25 volumio volumio[1131]: syscall: 'connect', Aug 25 22:41:25 volumio volumio[1131]: address: '158.69.210.98', Aug 25 22:41:25 volumio volumio[1131]: port: 443 Aug 25 22:41:25 volumio volumio[1131]: }, Aug 25 22:41:25 volumio volumio[1131]: Error: connect ECONNREFUSED 158.69.209.125:443 Aug 25 22:41:25 volumio volumio[1131]: at createConnectionError (node:net:1634:14) Aug 25 22:41:25 volumio volumio[1131]: at afterConnectMultiple (node:net:1664:40) { Aug 25 22:41:25 volumio volumio[1131]: errno: -111, Aug 25 22:41:25 volumio volumio[1131]: code: 'ECONNREFUSED', Aug 25 22:41:25 volumio volumio[1131]: syscall: 'connect', Aug 25 22:41:25 volumio volumio[1131]: address: '158.69.209.125', Aug 25 22:41:25 volumio volumio[1131]: port: 443 Aug 25 22:41:25 volumio volumio[1131]: } Aug 25 22:41:25 volumio volumio[1131]: ] Aug 25 22:41:25 volumio volumio[1131]: } Aug 25 22:41:25 volumio volumio[1131]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 25 22:41:25 volumio sudo[9404]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-25 22:40' Aug 25 22:41:25 volumio sudo[9404]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"