Dec 20 18:39:01 volumio volumio[1271]: info: CoreCommandRouter::volumioGetState Dec 20 18:39:01 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:01 volumio volumio[1271]: verbose: New Socket.io Connection to 192.168.1.194:3000 from 192.168.1.226 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 18:39:01 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:39:01 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:39:01 volumio volumio[1271]: info: Discovery: Getting this device information Dec 20 18:39:01 volumio volumio[1271]: info: CoreCommandRouter::volumioGetState Dec 20 18:39:01 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:01 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:39:03 volumio volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 18:39:03 volumio volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 18:39:03 volumio volumio[1271]: info: Retrieving Cloud Streaming UI Dec 20 18:39:03 volumio volumio[1271]: info: Getting Tidal Cloud Configuration Dec 20 18:39:03 volumio volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 18:39:03 volumio volumio[1271]: info: Getting Qobuz Cloud Configuration Dec 20 18:39:03 volumio volumio[1271]: info: Asking plugin for UI Config Dec 20 18:39:03 volumio volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 18:39:03 volumio volumio[1271]: info: Getting Spotify Cloud Configuration Dec 20 18:39:03 volumio volumio[1271]: info: Asking plugin for UI Config Dec 20 18:39:03 volumio volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 18:39:03 volumio volumio[1271]: info: Saving Spotify Acccount Dec 20 18:39:03 volumio volumio[1271]: info: Got Tidal Cloud Configuration Dec 20 18:39:03 volumio volumio[1271]: info: Got it Dec 20 18:39:03 volumio volumio[1271]: info: Got it Dec 20 18:39:03 volumio volumio[1271]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Dec 20 18:39:03 volumio volumio[1271]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 20 18:39:04 volumio volumio[1271]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::volumioGetBrowseSources Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 18:39:04 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand rescan Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:07 volumio volumio[1271]: info: Dec 20 18:39:07 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand rescan took 2 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:07 volumio volumio[1271]: info: Dec 20 18:39:07 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:07 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:07 volumio volumio[1271]: info: Dec 20 18:39:07 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:07 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand status took 3 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand status took 3 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand status took 1 milliseconds Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:07 volumio volumio[1271]: info: Command Router : Notfying DB Updatetrue Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:07 volumio volumio[1271]: info: Command Router : Notfying DB Updatetrue Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:07 volumio volumio[1271]: info: Command Router : Notfying DB Updatetrue Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 47 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 35 milliseconds Dec 20 18:39:07 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:07 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:07 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31934,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1033 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:07 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:07 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:07 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31934,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1033 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:07 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:07 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:07 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":31934,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1033 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:07 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:07 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:07 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:07 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:07 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:07 volumio volumio[1271]: info: ------------------------------ 175ms Dec 20 18:39:07 volumio volumio[1271]: info: ------------------------------ 175ms Dec 20 18:39:07 volumio volumio[1271]: info: ------------------------------ 175ms Dec 20 18:39:08 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:08 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:08 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:08 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:08 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:08 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:08 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 18:39:10 volumio volumio[1271]: info: MPD Database updated - AlbumList cache refreshed Dec 20 18:39:10 volumio volumio[1271]: info: Dec 20 18:39:10 volumio volumio[1271]: ---------------------------- MPD announces state update: database Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: Dec 20 18:39:10 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:10 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: MPD Database updated - AlbumList cache refreshed Dec 20 18:39:10 volumio volumio[1271]: info: Dec 20 18:39:10 volumio volumio[1271]: ---------------------------- MPD announces state update: database Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: Dec 20 18:39:10 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:10 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: MPD Database updated - AlbumList cache refreshed Dec 20 18:39:10 volumio volumio[1271]: info: Dec 20 18:39:10 volumio volumio[1271]: ---------------------------- MPD announces state update: database Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: Dec 20 18:39:10 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:10 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:10 volumio volumio[1271]: info: sendMpdCommand status took 67 milliseconds Dec 20 18:39:10 volumio volumio[1271]: info: sendMpdCommand status took 66 milliseconds Dec 20 18:39:10 volumio volumio[1271]: info: sendMpdCommand status took 66 milliseconds Dec 20 18:39:10 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: info: Command Router : Notfying DB Updatefalse Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand status took 156 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand status took 156 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand status took 157 milliseconds Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: info: Command Router : Notfying DB Updatefalse Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand status took 199 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand status took 200 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand status took 200 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 72 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 73 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 34 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 34 milliseconds Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: info: Command Router : Notfying DB Updatefalse Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:11 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35029,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1069 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:11 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:11 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35029,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1184 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:11 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:11 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35121,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1042 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:11 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:11 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35121,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1042 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:11 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:11 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: ------------------------------ 242ms Dec 20 18:39:11 volumio volumio[1271]: info: ------------------------------ 241ms Dec 20 18:39:11 volumio volumio[1271]: info: ------------------------------ 240ms Dec 20 18:39:11 volumio volumio[1271]: info: ------------------------------ 241ms Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 20 18:39:11 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:11 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:11 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35121,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1042 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:11 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:11 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":35121,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1042 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:11 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:11 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:11 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:11 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:11 volumio volumio[1271]: info: ------------------------------ 252ms Dec 20 18:39:11 volumio volumio[1271]: info: ------------------------------ 253ms Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:11 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:12 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 18:39:12 volumio go-librespot[1549]: time="2025-12-20T18:39:12+02:00" level=trace msg="received accesspoint ping" Dec 20 18:39:12 volumio go-librespot[1549]: time="2025-12-20T18:39:12+02:00" level=trace msg="received accesspoint pong ack" Dec 20 18:39:15 volumio go-librespot[1549]: time="2025-12-20T18:39:15+02:00" level=trace msg="sent dealer ping" Dec 20 18:39:15 volumio go-librespot[1549]: time="2025-12-20T18:39:15+02:00" level=trace msg="received dealer pong" Dec 20 18:39:16 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand update Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand update took 2 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 1 milliseconds Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: info: Command Router : Notfying DB Updatetrue Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 3 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 1 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: info: Command Router : Notfying DB Updatetrue Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: info: Command Router : Notfying DB Updatetrue Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42136,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1197 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 54ms Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 27 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42228,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42228,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 55ms Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 54ms Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: info: MPD Database updated - AlbumList cache refreshed Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: database Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: MPD Database updated - AlbumList cache refreshed Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: database Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: MPD Database updated - AlbumList cache refreshed Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: database Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: Dec 20 18:39:18 volumio volumio[1271]: ---------------------------- MPD announces state update: update Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 44 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 45 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 44 milliseconds Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: info: Command Router : Notfying DB Updatefalse Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 111 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 111 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 111 milliseconds Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: info: Command Router : Notfying DB Updatefalse Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 152 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 153 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand status took 153 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 70 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 70 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 29 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 29 milliseconds Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: info: Command Router : Notfying DB Updatefalse Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::Close All Modals sent Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42342,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42342,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1125 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42434,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1136 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42434,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1136 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 213ms Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 214ms Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 213ms Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 214ms Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 58 milliseconds Dec 20 18:39:18 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 58 milliseconds Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42434,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1136 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":42434,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1136 Kbps","isStreaming":false,"title":"Diesel Power","artist":"Prodigy","album":"The Fat Of The Land","uri":"INTERNAL/Prodigy - The Fat Of The Land (FLAC)/03 Diesel Power.flac","trackType":"flac"} Dec 20 18:39:18 volumio volumio[1271]: verbose: CURRENT POSITION 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:18 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:18 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:18 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 244ms Dec 20 18:39:18 volumio volumio[1271]: info: ------------------------------ 245ms Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:18 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:20 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 18:39:24 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 20 18:39:28 volumio volumio[1271]: info: CoreCommandRouter::volumioGetState Dec 20 18:39:28 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:33 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 18:39:33 volumio volumio[1271]: info: CURURI: music-library Dec 20 18:39:33 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:39:34 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 18:39:34 volumio volumio[1271]: info: CURURI: music-library/INTERNAL Dec 20 18:39:34 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:39:45 volumio go-librespot[1549]: time="2025-12-20T18:39:45+02:00" level=trace msg="sent dealer ping" Dec 20 18:39:45 volumio go-librespot[1549]: time="2025-12-20T18:39:45+02:00" level=trace msg="received dealer pong" Dec 20 18:39:49 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 20 18:39:49 volumio volumio[1271]: info: CURURI: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC] Dec 20 18:39:49 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/01-Atrocity Exhibition.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/02-Isolation.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/03-Passover.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/04-Colony.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/05-A Means To An End.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/07-Twenty Four Hours.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/08-The Eternal.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/09-Decades.flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/11-Glass - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/12-A Means To An End - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/13-Twenty Four Hours - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/14-Passover - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/15-Insight - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/16-Colony - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/17-These Days - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/18-Love Will Tear Us Apart - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/19-Isolation - [University of London Union Live 8].flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/20-The Eternal - [University of London Union Live 8] (Encore).flac Dec 20 18:39:49 volumio volumio[1271]: info: Preloading song: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/21-Digital - [University of London Union Live 8] (Encore).flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/01-Atrocity Exhibition.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F01-Atrocity%20Exhibition.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/01-Atrocity Exhibition.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/02-Isolation.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F02-Isolation.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/02-Isolation.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/03-Passover.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F03-Passover.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/03-Passover.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/04-Colony.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F04-Colony.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/04-Colony.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/05-A Means To An End.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F05-A%20Means%20To%20An%20End.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/05-A Means To An End.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F06-Heart%20And%20Soul.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/07-Twenty Four Hours.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F07-Twenty%20Four%20Hours.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/07-Twenty Four Hours.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/08-The Eternal.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F08-The%20Eternal.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/08-The Eternal.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/09-Decades.flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2001)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F09-Decades.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/09-Decades.flac Dec 20 18:39:49 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac in service mpd Dec 20 18:39:49 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F10-Dead%20Souls%20-%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:49 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/11-Glass - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F11-Glass%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/11-Glass - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/12-A Means To An End - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F12-A%20Means%20To%20An%20End%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/12-A Means To An End - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/13-Twenty Four Hours - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F13-Twenty%20Four%20Hours%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/13-Twenty Four Hours - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/14-Passover - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F14-Passover%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/14-Passover - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/15-Insight - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F15-Insight%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/15-Insight - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/16-Colony - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F16-Colony%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/16-Colony - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/17-These Days - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F17-These%20Days%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/17-These Days - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/18-Love Will Tear Us Apart - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F18-Love%20Will%20Tear%20Us%20Apart%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/18-Love Will Tear Us Apart - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/19-Isolation - [University of London Union Live 8].flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F19-Isolation%20-%20%5BUniversity%20of%20London%20Union%20Live%208%5D.flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/19-Isolation - [University of London Union Live 8].flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/20-The Eternal - [University of London Union Live 8] (Encore).flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F20-The%20Eternal%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D%20(Encore).flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/20-The Eternal - [University of London Union Live 8] (Encore).flac Dec 20 18:39:50 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/21-Digital - [University of London Union Live 8] (Encore).flac in service mpd Dec 20 18:39:50 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Joy%20Division/Closer%20(Collectors%20Edition%20Disc%2002)/extralarge&path=%2Fmnt%2FINTERNAL%2F1980%20-%20Joy%20Division%20-%20Closer%20%5BHDTracks%2024-192%20FLAC%5D%2F21-Digital%20-%20%20%5BUniversity%20of%20London%20Union%20Live%208%5D%20(Encore).flac&metadata=false Dec 20 18:39:50 volumio volumio[1271]: info: URI /mnt/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/21-Digital - [University of London Union Live 8] (Encore).flac Dec 20 18:39:54 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::ClearQueue Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::stop Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::stPlaybackTimer Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::updateTrackBlock Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrackBlock Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::serviceStop Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 2 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::serviceStop Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::stop Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::clearPlayQueue Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::saveQueue Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::addQueueItems Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::addQueueItems Dec 20 18:39:54 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/01-Atrocity Exhibition.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/01-Atrocity Exhibition.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/02-Isolation.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/02-Isolation.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/03-Passover.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/03-Passover.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/04-Colony.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/04-Colony.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/05-A Means To An End.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/05-A Means To An End.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::saveQueue Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::updateTrackBlock Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrackBlock Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPlay Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::play index 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::addQueueItems Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::addQueueItems Dec 20 18:39:54 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/07-Twenty Four Hours.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/07-Twenty Four Hours.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/08-The Eternal.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/08-The Eternal.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/09-Decades.flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/09-Decades.flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/11-Glass - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/11-Glass - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/12-A Means To An End - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/12-A Means To An End - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/13-Twenty Four Hours - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/13-Twenty Four Hours - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/14-Passover - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/14-Passover - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/15-Insight - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/15-Insight - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/16-Colony - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/16-Colony - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/17-These Days - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/17-These Days - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/18-Love Will Tear Us Apart - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/18-Love Will Tear Us Apart - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/19-Isolation - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/19-Isolation - [University of London Union Live 8].flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/20-The Eternal - [University of London Union Live 8] (Encore).flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/20-The Eternal - [University of London Union Live 8] (Encore).flac Dec 20 18:39:54 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/21-Digital - [University of London Union Live 8] (Encore).flac Dec 20 18:39:54 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/21-Digital - [University of London Union Live 8] (Encore).flac Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::stop Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::saveQueue Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::play index undefined Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::updateTrackBlock Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrackBlock Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::startPlaybackTimer Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand stop took 25 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand stop took 5 milliseconds Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:39:54 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 3 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand clear took 2 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 1 milliseconds Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac" Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: 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} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService stop Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: No code Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: 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} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService stop Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: No code Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 17ms Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 18ms Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:39:54 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:39:54 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:39:54 volumio volumio[1271]: error: updateQueue error: null Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:39:54 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 18ms Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand add "INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac" took 17 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 2ms Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand play Dec 20 18:39:54 volumio volumio[1271]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 23ms Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:39:54 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 10ms Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 9ms Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand play took 8 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 7ms Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:39:54 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 2ms Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 19 milliseconds Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 25 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 24 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":351,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Heart And Soul","artist":"Joy Division","album":"Closer (Collectors Edition Disc 01)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac","trackType":"flac"} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 31ms Dec 20 18:39:54 volumio volumio[1271]: info: Dec 20 18:39:54 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 10 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 10 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand status took 3 milliseconds Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":351,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5219 Kbps","isStreaming":false,"title":"Heart And Soul","artist":"Joy Division","album":"Closer (Collectors Edition Disc 01)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac","trackType":"flac"} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:54 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":65,"duration":351,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5219 Kbps","isStreaming":false,"title":"Heart And Soul","artist":"Joy Division","album":"Closer (Collectors Edition Disc 01)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac","trackType":"flac"} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:54 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 55ms Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 54ms Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 19 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 20 milliseconds Dec 20 18:39:54 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 18 milliseconds Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:54 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":678,"duration":351,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5202 Kbps","isStreaming":false,"title":"Heart And Soul","artist":"Joy Division","album":"Closer (Collectors Edition Disc 01)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac","trackType":"flac"} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:54 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":678,"duration":351,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5202 Kbps","isStreaming":false,"title":"Heart And Soul","artist":"Joy Division","album":"Closer (Collectors Edition Disc 01)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac","trackType":"flac"} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:54 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":678,"duration":351,"samplerate":"192 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5202 Kbps","isStreaming":false,"title":"Heart And Soul","artist":"Joy Division","album":"Closer (Collectors Edition Disc 01)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac","trackType":"flac"} Dec 20 18:39:54 volumio volumio[1271]: verbose: CURRENT POSITION 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:39:54 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:39:54 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:39:54 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 54ms Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 53ms Dec 20 18:39:54 volumio volumio[1271]: info: ------------------------------ 46ms Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:39:54 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:15 volumio go-librespot[1549]: time="2025-12-20T18:40:15+02:00" level=trace msg="sent dealer ping" Dec 20 18:40:16 volumio go-librespot[1549]: time="2025-12-20T18:40:16+02:00" level=trace msg="received dealer pong" Dec 20 18:40:21 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::ClearQueue Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::stop Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::stPlaybackTimer Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::updateTrackBlock Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrackBlock Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::serviceStop Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 5 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::serviceStop Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::stop Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::clearPlayQueue Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::saveQueue Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::addQueueItems Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::addQueueItems Dec 20 18:40:21 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/01-Atrocity Exhibition.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/01-Atrocity Exhibition.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/02-Isolation.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/02-Isolation.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/03-Passover.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/03-Passover.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/04-Colony.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/04-Colony.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/05-A Means To An End.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/05-A Means To An End.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/06-Heart And Soul.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/07-Twenty Four Hours.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/07-Twenty Four Hours.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/08-The Eternal.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/08-The Eternal.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/09-Decades.flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/09-Decades.flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::saveQueue Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::updateTrackBlock Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrackBlock Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPlay Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::play index 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::addQueueItems Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::addQueueItems Dec 20 18:40:21 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/11-Glass - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/11-Glass - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/12-A Means To An End - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/12-A Means To An End - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/13-Twenty Four Hours - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/13-Twenty Four Hours - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/14-Passover - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/14-Passover - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/15-Insight - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/15-Insight - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/16-Colony - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/16-Colony - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/17-These Days - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/17-These Days - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/18-Love Will Tear Us Apart - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/18-Love Will Tear Us Apart - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/19-Isolation - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/19-Isolation - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/20-The Eternal - [University of London Union Live 8] (Encore).flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/20-The Eternal - [University of London Union Live 8] (Encore).flac Dec 20 18:40:21 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/21-Digital - [University of London Union Live 8] (Encore).flac Dec 20 18:40:21 volumio volumio[1271]: info: Using cached record of: music-library/INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/21-Digital - [University of London Union Live 8] (Encore).flac Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::stop Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::saveQueue Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::play index undefined Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::updateTrackBlock Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrackBlock Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::startPlaybackTimer Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand stop took 20 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand stop took 4 milliseconds Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand clear Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:40:21 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 5 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand clear took 4 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 4 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 3 milliseconds Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac" Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: 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} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService stop Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: No code Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: 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} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService stop Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: No code Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 14ms Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 15ms Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:40:21 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:40:21 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:40:21 volumio volumio[1271]: error: updateQueue error: null Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:40:21 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 15ms Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand add "INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac" took 14 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 3ms Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 2ms Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand play Dec 20 18:40:21 volumio volumio[1271]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 20ms Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:40:21 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces system playlist update Dec 20 18:40:21 volumio volumio[1271]: info: Ignoring MPD Status Update Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 8ms Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand play took 7 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 7ms Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 6ms Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 19 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 19 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 18 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 1 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 2 milliseconds Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":299,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1 Kbps","isStreaming":false,"title":"Dead Souls - [University of London Union Live 8]","artist":"Joy Division","album":"Closer (Collectors Edition Disc 02)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac","trackType":"flac"} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus stop Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 22ms Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: Dec 20 18:40:21 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand status took 2 milliseconds Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseState Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":252,"duration":299,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"437 Kbps","isStreaming":false,"title":"Dead Souls - [University of London Union Live 8]","artist":"Joy Division","album":"Closer (Collectors Edition Disc 02)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac","trackType":"flac"} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:40:21 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":299,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"447 Kbps","isStreaming":false,"title":"Dead Souls - [University of London Union Live 8]","artist":"Joy Division","album":"Closer (Collectors Edition Disc 02)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac","trackType":"flac"} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:40:21 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":299,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"536 Kbps","isStreaming":false,"title":"Dead Souls - [University of London Union Live 8]","artist":"Joy Division","album":"Closer (Collectors Edition Disc 02)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac","trackType":"flac"} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:40:21 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 44ms Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 45ms Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 29ms Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 22 milliseconds Dec 20 18:40:21 volumio volumio[1271]: info: sendMpdCommand playlistinfo took 23 milliseconds Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:40:21 volumio volumio[1271]: verbose: ControllerMpd::parseTrackInfo Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":299,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"536 Kbps","isStreaming":false,"title":"Dead Souls - [University of London Union Live 8]","artist":"Joy Division","album":"Closer (Collectors Edition Disc 02)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac","trackType":"flac"} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:40:21 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: ControllerMpd::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::servicePushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":299,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"536 Kbps","isStreaming":false,"title":"Dead Souls - [University of London Union Live 8]","artist":"Joy Division","album":"Closer (Collectors Edition Disc 02)","uri":"INTERNAL/1980 - Joy Division - Closer [HDTracks 24-192 FLAC]/10-Dead Souls - [University of London Union Live 8].flac","trackType":"flac"} Dec 20 18:40:21 volumio volumio[1271]: verbose: CURRENT POSITION 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState stateService play Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::syncState currentStatus play Dec 20 18:40:21 volumio volumio[1271]: info: Received an update from plugin. extracting info from payload Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:21 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:21 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 38ms Dec 20 18:40:21 volumio volumio[1271]: info: ------------------------------ 38ms Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:21 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:27 volumio volumio[1271]: verbose: New Socket.io Connection to 192.168.1.194:3000 from 192.168.1.226 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Dec 20 18:40:27 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 20 18:40:27 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 20 18:40:27 volumio volumio[1271]: info: Discovery: Getting this device information Dec 20 18:40:27 volumio volumio[1271]: info: CoreCommandRouter::volumioGetState Dec 20 18:40:27 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:27 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 20 18:40:45 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:40:45 volumio volumio[1271]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::ClearQueue Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::stop Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::stPlaybackTimer Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::updateTrackBlock Dec 20 18:40:45 volumio volumio[1271]: info: CorePlayQueue::getTrackBlock Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::pushState Dec 20 18:40:45 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:45 volumio volumio[1271]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 20 18:40:45 volumio volumio[1271]: info: CoreCommandRouter::volumioPushState Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::serviceStop Dec 20 18:40:45 volumio volumio[1271]: info: CorePlayQueue::getTrack 9 Dec 20 18:40:45 volumio volumio[1271]: info: CoreCommandRouter::serviceStop Dec 20 18:40:45 volumio volumio[1271]: info: ControllerMpd::stop Dec 20 18:40:45 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand stop Dec 20 18:40:45 volumio volumio[1271]: info: CorePlayQueue::clearPlayQueue Dec 20 18:40:45 volumio volumio[1271]: info: CorePlayQueue::saveQueue Dec 20 18:40:45 volumio volumio[1271]: info: CoreCommandRouter::volumioPushQueue Dec 20 18:40:45 volumio volumio[1271]: info: CoreStateMachine::addQueueItems Dec 20 18:40:45 volumio volumio[1271]: info: CorePlayQueue::addQueueItems Dec 20 18:40:45 volumio volumio[1271]: info: Preload queue cleared Dec 20 18:40:45 volumio volumio[1271]: info: Adding Item to queue: music-library/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup Dec 20 18:40:45 volumio volumio[1271]: info: Exploding uri music-library/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup in service mpd Dec 20 18:40:45 volumio volumio[1271]: SPOTIFY: RECEIVED VOLUMIO VOLUME 84 Dec 20 18:40:45 volumio volumio[1271]: info: Dec 20 18:40:45 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:45 volumio volumio[1271]: info: sendMpdCommand stop took 13 milliseconds Dec 20 18:40:45 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:45 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:45 volumio volumio[1271]: info: Dec 20 18:40:45 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:45 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:45 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:45 volumio volumio[1271]: info: Dec 20 18:40:45 volumio volumio[1271]: ---------------------------- MPD announces state update: player Dec 20 18:40:45 volumio volumio[1271]: info: ControllerMpd::getState Dec 20 18:40:45 volumio volumio[1271]: verbose: ControllerMpd::sendMpdCommand status Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F01.%20The%20Road%20to%20Hell%2C%20Part%202.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/01. The Road to Hell, Part 2.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F02.%20You%20Can%20Go%20Your%20Own%20Way.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/02. You Can Go Your Own Way.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F03.%20Josephine.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/03. Josephine.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F04.%20Let's%20Dance.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/04. Let's Dance.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F05.%20Fool%20(If%20You%20Think%20It's%20Over).flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/05. Fool (If You Think It's Over).flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F06.%20The%20Things%20Lovers%20Should%20Do.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/06. The Things Lovers Should Do.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F07.%20Wired%20to%20the%20Moon.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/07. Wired to the Moon.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F08.%20I%20Can%20Hear%20Your%20Heartbeat.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/08. I Can Hear Your Heartbeat.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F09.%20On%20the%20Beach.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/09. On the Beach.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F10.%20Ace%20of%20Hearts.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/10. Ace of Hearts.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F11.%20Julia.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/11. Julia.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F12.%20Auberge.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/12. Auberge.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F13.%20Looking%20for%20the%20Summer.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/13. Looking for the Summer.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F14.%20I%20Don't%20Know%20What%20It%20Is%20but%20I%20Love%20It.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/14. I Don't Know What It Is but I Love It.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2F15.%20Love's%20Strange%20Ways.flac&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/15. Love's Strange Ways.flac Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2FChris%20Rea%20-%20The%20Platinum%20Collection.cue&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/Chris Rea - The Platinum Collection.cue Dec 20 18:40:45 volumio volumio[1271]: info: ALBUMART /albumart?cacheid=351&web=Chris%20Rea/The%20Platinum%20Collection/extralarge&path=%2Fmnt%2FINTERNAL%2FChris%20Rea%20-%20The%20Platinum%20Collection%20(2006)%20FLAC%20Soup%2FChris%20Rea%20-%20The%20Platinum%20Collection.cue&metadata=false Dec 20 18:40:45 volumio volumio[1271]: info: URI /mnt/INTERNAL/Chris Rea - The Platinum Collection (2006) FLAC Soup/Chris Rea - The Platinum Collection.cue Dec 20 18:40:45 volumio volumio[1271]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 18:40:45 volumio volumio[1271]: Error: Unable to resolve or reject the same promise twice Dec 20 18:40:45 volumio volumio[1271]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Dec 20 18:40:45 volumio volumio[1271]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Dec 20 18:40:45 volumio volumio[1271]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Dec 20 18:40:45 volumio volumio[1271]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Dec 20 18:40:45 volumio volumio[1271]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Dec 20 18:40:45 volumio volumio[1271]: at Socket.emit (node:events:514:28) Dec 20 18:40:45 volumio volumio[1271]: at addChunk (node:internal/streams/readable:343:12) Dec 20 18:40:45 volumio volumio[1271]: at readableAddChunk (node:internal/streams/readable:312:11) Dec 20 18:40:45 volumio volumio[1271]: at Readable.push (node:internal/streams/readable:253:10) Dec 20 18:40:45 volumio volumio[1271]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Dec 20 18:40:45 volumio volumio[1271]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 20 18:40:45 volumio go-librespot[1549]: time="2025-12-20T18:40:45+02:00" level=trace msg="sent dealer ping" Dec 20 18:40:45 volumio go-librespot[1549]: time="2025-12-20T18:40:45+02:00" level=trace msg="received dealer pong" Dec 20 18:40:47 volumio sudo[24630]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-20 18:39' Dec 20 18:40:47 volumio sudo[24630]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"