Feb 25 12:26:21 volumio volumio[1377]: info: CorePlayQueue::getTrack 3
Feb 25 12:26:21 volumio volumio[1377]: info: CorePlayQueue::getTrack 4
Feb 25 12:26:21 volumio volumio[1377]: info: Prefetching next song
Feb 25 12:26:21 volumio volumio[1377]: info: DOING PREFETCH IN MPD
Feb 25 12:26:21 volumio volumio[1377]: verbose: ControllerMpd::sendMpdCommand add "NAS/Flac/Caligula’s Horse/Charcoal Grace/05 - Charcoal Grace III_ Vigil.flac"
Feb 25 12:26:21 volumio volumio[1377]: info:
Feb 25 12:26:21 volumio volumio[1377]: ---------------------------- MPD announces system playlist update
Feb 25 12:26:21 volumio volumio[1377]: info: Ignoring MPD Status Update
Feb 25 12:26:21 volumio volumio[1377]: info: sendMpdCommand add "NAS/Flac/Caligula’s Horse/Charcoal Grace/05 - Charcoal Grace III_ Vigil.flac" took 1 milliseconds
Feb 25 12:26:21 volumio volumio[1377]: verbose: ControllerMpd::sendMpdCommand consume 1
Feb 25 12:26:21 volumio volumio[1377]: info:
Feb 25 12:26:21 volumio volumio[1377]: ---------------------------- MPD announces system playlist update
Feb 25 12:26:21 volumio volumio[1377]: info: Ignoring MPD Status Update
Feb 25 12:26:21 volumio volumio[1377]: info: ------------------------------ 0ms
Feb 25 12:26:21 volumio volumio[1377]: info: sendMpdCommand consume 1 took 0 milliseconds
Feb 25 12:26:21 volumio volumio[1377]: info: ------------------------------ 0ms
Feb 25 12:26:25 volumio volumio[1377]: info:
Feb 25 12:26:25 volumio volumio[1377]: ---------------------------- MPD announces system playlist update
Feb 25 12:26:25 volumio volumio[1377]: info: Ignoring MPD Status Update
Feb 25 12:26:25 volumio volumio[1377]: info:
Feb 25 12:26:25 volumio volumio[1377]: ---------------------------- MPD announces state update: player
Feb 25 12:26:25 volumio volumio[1377]: info: ControllerMpd::getState
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 12:26:25 volumio volumio[1377]: info:
Feb 25 12:26:25 volumio volumio[1377]: ---------------------------- MPD announces system playlist update
Feb 25 12:26:25 volumio volumio[1377]: info: Ignoring MPD Status Update
Feb 25 12:26:25 volumio volumio[1377]: info:
Feb 25 12:26:25 volumio volumio[1377]: ---------------------------- MPD announces state update: player
Feb 25 12:26:25 volumio volumio[1377]: info: ControllerMpd::getState
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::sendMpdCommand status
Feb 25 12:26:25 volumio volumio[1377]: info: ------------------------------ 1ms
Feb 25 12:26:25 volumio volumio[1377]: info: sendMpdCommand status took 0 milliseconds
Feb 25 12:26:25 volumio volumio[1377]: info: ------------------------------ 0ms
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::parseState
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 12:26:25 volumio volumio[1377]: info: sendMpdCommand status took 0 milliseconds
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::parseState
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Feb 25 12:26:25 volumio volumio[1377]: info: sendMpdCommand playlistinfo took 0 milliseconds
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::parseTrackInfo
Feb 25 12:26:25 volumio volumio[1377]: info: ControllerMpd::pushState
Feb 25 12:26:25 volumio volumio[1377]: info: CoreCommandRouter::servicePushState
Feb 25 12:26:25 volumio volumio[1377]: info: CorePlayQueue::getTrack 3
Feb 25 12:26:25 volumio volumio[1377]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1323 Kbps","isStreaming":false,"title":"Charcoal Grace III: Vigil","artist":"Caligula’s Horse","album":"Charcoal Grace","uri":"NAS/Flac/Caligula’s Horse/Charcoal Grace/05 - Charcoal Grace III_ Vigil.flac","trackType":"flac"}
Feb 25 12:26:25 volumio volumio[1377]: verbose: CURRENT POSITION 3
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::syncState stateService play
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::syncState currentStatus play
Feb 25 12:26:25 volumio volumio[1377]: info: Received an update from plugin. extracting info from payload
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::pushState
Feb 25 12:26:25 volumio volumio[1377]: info: CorePlayQueue::getTrack 3
Feb 25 12:26:25 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 12:26:25 volumio volumio[1377]: info: CoreCommandRouter::volumioPushState
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::pushState
Feb 25 12:26:25 volumio volumio[1377]: info: CorePlayQueue::getTrack 3
Feb 25 12:26:25 volumio volumio[1377]: info: CoreCommandRouter::volumioPushState
Feb 25 12:26:25 volumio volumio[1377]: info: ------------------------------ 3ms
Feb 25 12:26:25 volumio volumio[1377]: info: sendMpdCommand playlistinfo took 2 milliseconds
Feb 25 12:26:25 volumio volumio[1377]: verbose: ControllerMpd::parseTrackInfo
Feb 25 12:26:25 volumio volumio[1377]: info: ControllerMpd::pushState
Feb 25 12:26:25 volumio volumio[1377]: info: CoreCommandRouter::servicePushState
Feb 25 12:26:25 volumio volumio[1377]: info: CorePlayQueue::getTrack 3
Feb 25 12:26:25 volumio volumio[1377]: verbose: STATE SERVICE {"status":"play","position":0,"seek":104,"duration":202,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1323 Kbps","isStreaming":false,"title":"Charcoal Grace III: Vigil","artist":"Caligula’s Horse","album":"Charcoal Grace","uri":"NAS/Flac/Caligula’s Horse/Charcoal Grace/05 - Charcoal Grace III_ Vigil.flac","trackType":"flac"}
Feb 25 12:26:25 volumio volumio[1377]: verbose: CURRENT POSITION 3
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::syncState stateService play
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::syncState currentStatus play
Feb 25 12:26:25 volumio volumio[1377]: info: Received an update from plugin. extracting info from payload
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::pushState
Feb 25 12:26:25 volumio volumio[1377]: info: CorePlayQueue::getTrack 3
Feb 25 12:26:25 volumio volumio[1377]: info: CoreCommandRouter::volumioPushState
Feb 25 12:26:25 volumio volumio[1377]: info: CoreStateMachine::pushState
Feb 25 12:26:25 volumio volumio[1377]: info: CorePlayQueue::getTrack 3
Feb 25 12:26:25 volumio volumio[1377]: info: CoreCommandRouter::volumioPushState
Feb 25 12:26:25 volumio volumio[1377]: info: ------------------------------ 5ms
Feb 25 12:26:26 volumio volumio[1377]: info: CoreStateMachine::startPlaybackTimer
Feb 25 12:26:26 volumio volumio[1377]: info: CorePlayQueue::getTrack 4
Feb 25 12:26:26 volumio volumio[1377]: info: CoreStateMachine::pushState
Feb 25 12:26:26 volumio volumio[1377]: info: CorePlayQueue::getTrack 4
Feb 25 12:26:26 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 25 12:26:26 volumio volumio[1377]: info: CoreCommandRouter::volumioPushState
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 12:26:58 volumio volumio[1377]: info: Retrieving Cloud Streaming UI
Feb 25 12:26:58 volumio volumio[1377]: info: Getting Tidal Cloud Configuration
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 12:26:58 volumio volumio[1377]: info: Getting Qobuz Cloud Configuration
Feb 25 12:26:58 volumio volumio[1377]: info: Asking plugin for UI Config
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 12:26:58 volumio volumio[1377]: info: Getting Spotify Cloud Configuration
Feb 25 12:26:58 volumio volumio[1377]: info: Asking plugin for UI Config
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 12:26:58 volumio volumio[1377]: info: Saving Spotify Acccount
Feb 25 12:26:58 volumio volumio[1377]: info: Got Tidal Cloud Configuration
Feb 25 12:26:58 volumio volumio[1377]: info: Got it
Feb 25 12:26:58 volumio volumio[1377]: info: Got it
Feb 25 12:26:58 volumio volumio[1377]: error: Could not retrieve Spotify Config from plugin Spotify: no section found
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 25 12:26:58 volumio volumio[1377]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave')
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::volumioGetBrowseSources
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 25 12:26:58 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Feb 25 12:27:02 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Feb 25 12:27:07 volumio volumio[1377]: info: CoreCommandRouter::volumioGetState
Feb 25 12:27:07 volumio volumio[1377]: info: CorePlayQueue::getTrack 4
Feb 25 12:27:18 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Feb 25 12:27:18 volumio volumio[1377]: info: CURURI: music-library
Feb 25 12:27:18 volumio volumio[1377]: info: Preload queue cleared
Feb 25 12:27:26 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 25 12:27:26 volumio volumio[1377]: info: UPNP Browser: No servers found, reinitializing and searching...
Feb 25 12:27:29 volumio volumio[1377]: info: UPNP Browser: Returning 1 server(s) after 3s wait
Feb 25 12:27:29 volumio volumio[1377]: info: Preload queue cleared
Feb 25 12:27:31 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 25 12:27:31 volumio volumio[1377]: info: Preload queue cleared
Feb 25 12:27:33 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 25 12:27:33 volumio volumio[1377]: info: Preload queue cleared
Feb 25 12:27:43 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 25 12:27:43 volumio volumio[1377]: info: Preload queue cleared
Feb 25 12:27:44 volumio volumio[1377]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Feb 25 12:27:44 volumio volumio[1377]: info: Preload queue cleared
Feb 25 12:27:46 volumio volumio[1377]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 12:27:46 volumio volumio[1377]: TypeError: Cannot read properties of null (reading 'slice')
Feb 25 12:27:46 volumio volumio[1377]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41)
Feb 25 12:27:46 volumio volumio[1377]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7)
Feb 25 12:27:46 volumio volumio[1377]: at Object.onceWrapper (node:events:629:26)
Feb 25 12:27:46 volumio volumio[1377]: at ClientRequest.emit (node:events:514:28)
Feb 25 12:27:46 volumio volumio[1377]: at HTTPParser.parserOnIncomingClient [as onIncoming] (node:_http_client:693:27)
Feb 25 12:27:46 volumio volumio[1377]: at HTTPParser.parserOnHeadersComplete (node:_http_common:119:17)
Feb 25 12:27:46 volumio volumio[1377]: at TLSSocket.socketOnData (node:_http_client:535:22)
Feb 25 12:27:46 volumio volumio[1377]: at TLSSocket.emit (node:events:514:28)
Feb 25 12:27:46 volumio volumio[1377]: at addChunk (node:internal/streams/readable:343:12)
Feb 25 12:27:46 volumio volumio[1377]: at readableAddChunk (node:internal/streams/readable:316:9)
Feb 25 12:27:46 volumio volumio[1377]: at Readable.push (node:internal/streams/readable:253:10)
Feb 25 12:27:46 volumio volumio[1377]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:190:23)
Feb 25 12:27:46 volumio volumio[1377]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 25 12:27:46 volumio sudo[163243]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 12:26'
Feb 25 12:27:46 volumio sudo[163243]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"