-- Logs begin at Thu 2026-04-09 23:55:20 CEST, end at Fri 2026-04-10 21:30:11 CEST. -- Apr 10 21:29:01 volumio volumio[671]: info: Preload queue cleared Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::ClearQueue Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::stop Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::updateTrackBlock Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrackBlock Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::stPlaybackTimer Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::serviceStop Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::serviceStop Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::stop Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::clearPlayQueue Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::saveQueue Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushQueue Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::addQueueItems Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::addQueueItems Apr 10 21:29:01 volumio volumio[671]: info: Preload queue cleared Apr 10 21:29:01 volumio volumio[671]: info: Adding Item to queue: music-library/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF Apr 10 21:29:01 volumio volumio[671]: info: Exploding uri music-library/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF in service mpd Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.01.%20Feels%20Like%20The%20First%20Time.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.02.%20Cold%20As%20Ice.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.02. Cold As Ice.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.03.%20Starrider.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.03. Starrider.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.04.%20Headknocker.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.04. Headknocker.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.05.%20The%20Damage%20Is%20Done.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.05. The Damage Is Done.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.06.%20Long%2C%20Long%20Way%20From%20Home.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.06. Long, Long Way From Home.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.07.%20Woman%20Oh%20Woman.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.07. Woman Oh Woman.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.08.%20At%20War%20With%20The%20World.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.08. At War With The World.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.09.%20Fool%20For%20You%20Anyway.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.09. Fool For You Anyway.dsf Apr 10 21:29:01 volumio volumio[671]: info: ALBUMART /albumart?cacheid=510&web=Foreigner/Foreigner%20(2023%20SACD%20Layer)/extralarge&path=%2Fmnt%2FUSB%2FBUZIPEN%2FForeigner%20(2023%20SACD%20Layer)%20DSF%2F2.10.%20I%20Need%20You.dsf&metadata=false Apr 10 21:29:01 volumio volumio[671]: info: URI /mnt/USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.10. I Need You.dsf Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand stop took 57 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushQueue Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::saveQueue Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::updateTrackBlock Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrackBlock Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPlay Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::play index 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::stop Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::play index undefined Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::startPlaybackTimer Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::clearAddPlayTracks USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand stop Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 54 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand stop took 15 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 12 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 10 milliseconds Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand clear Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: error: Upnp client error: Error: This socket has been ended by the other party Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces system playlist update Apr 10 21:29:01 volumio volumio[671]: info: Ignoring MPD Status Update Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand clear took 10 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand add "USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf" Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::pushState Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::servicePushState Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Má Vlast, JB1:112: 2. Vltava","artist":"Czech Philharmonic","album":"Smetana: Má Vlast","uri":"USB/KINGSTON/Music/Various Artists - Hi-Res Masters 50 Classical Tracks to Test your Speakers 24Bit-FLAC/01. Czech Philharmonic - Má Vlast, JB1_112_ 2. Vltava.flac","trackType":"flac"} Apr 10 21:29:01 volumio volumio[671]: verbose: CURRENT POSITION 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState stateService stop Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState currentStatus stop Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: No code Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 21:29:01 volumio volumio[671]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 164ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 107ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 105ms Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces system playlist update Apr 10 21:29:01 volumio volumio[671]: info: Ignoring MPD Status Update Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces system playlist update Apr 10 21:29:01 volumio volumio[671]: info: Ignoring MPD Status Update Apr 10 21:29:01 volumio volumio[671]: error: updateQueue error: null Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces system playlist update Apr 10 21:29:01 volumio volumio[671]: info: Ignoring MPD Status Update Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 97ms Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand add "USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf" took 91 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 12ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 10ms Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand play Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces system playlist update Apr 10 21:29:01 volumio volumio[671]: info: Ignoring MPD Status Update Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces system playlist update Apr 10 21:29:01 volumio volumio[671]: info: Ignoring MPD Status Update Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 25ms Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand play took 21 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 22ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 20ms Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 19 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 19 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 12 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 9 milliseconds Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: Apr 10 21:29:01 volumio volumio[671]: ---------------------------- MPD announces state update: player Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::getState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand status Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 27 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 20 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand status took 17 milliseconds Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseState Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::pushState Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::servicePushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Feels Like The First Time","artist":"Foreigner","album":"Foreigner (2023 SACD Layer)","uri":"USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf","trackType":"dsf"} Apr 10 21:29:01 volumio volumio[671]: verbose: CURRENT POSITION 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState stateService play Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState currentStatus stop Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::pushState Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::servicePushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Feels Like The First Time","artist":"Foreigner","album":"Foreigner (2023 SACD Layer)","uri":"USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf","trackType":"dsf"} Apr 10 21:29:01 volumio volumio[671]: verbose: CURRENT POSITION 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState stateService play Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState currentStatus play Apr 10 21:29:01 volumio volumio[671]: info: Received an update from plugin. extracting info from payload Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::pushState Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::servicePushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Feels Like The First Time","artist":"Foreigner","album":"Foreigner (2023 SACD Layer)","uri":"USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf","trackType":"dsf"} Apr 10 21:29:01 volumio volumio[671]: verbose: CURRENT POSITION 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState stateService play Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState currentStatus play Apr 10 21:29:01 volumio volumio[671]: info: Received an update from plugin. extracting info from payload Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::pushState Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::servicePushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":232,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Feels Like The First Time","artist":"Foreigner","album":"Foreigner (2023 SACD Layer)","uri":"USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf","trackType":"dsf"} Apr 10 21:29:01 volumio volumio[671]: verbose: CURRENT POSITION 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState stateService play Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState currentStatus play Apr 10 21:29:01 volumio volumio[671]: info: Received an update from plugin. extracting info from payload Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 148ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 249ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 240ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 238ms Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 222 milliseconds Apr 10 21:29:01 volumio volumio[671]: info: sendMpdCommand playlistinfo took 222 milliseconds Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: verbose: ControllerMpd::parseTrackInfo Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::pushState Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::servicePushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":232,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Feels Like The First Time","artist":"Foreigner","album":"Foreigner (2023 SACD Layer)","uri":"USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf","trackType":"dsf"} Apr 10 21:29:01 volumio volumio[671]: verbose: CURRENT POSITION 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState stateService play Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState currentStatus play Apr 10 21:29:01 volumio volumio[671]: info: Received an update from plugin. extracting info from payload Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: ControllerMpd::pushState Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::servicePushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: verbose: STATE SERVICE {"status":"play","position":0,"seek":142,"duration":232,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"Feels Like The First Time","artist":"Foreigner","album":"Foreigner (2023 SACD Layer)","uri":"USB/BUZIPEN/Foreigner (2023 SACD Layer) DSF/2.01. Feels Like The First Time.dsf","trackType":"dsf"} Apr 10 21:29:01 volumio volumio[671]: verbose: CURRENT POSITION 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState stateService play Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::syncState currentStatus play Apr 10 21:29:01 volumio volumio[671]: info: Received an update from plugin. extracting info from payload Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: CoreStateMachine::pushState Apr 10 21:29:01 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:01 volumio volumio[671]: info: CoreCommandRouter::volumioPushState Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 372ms Apr 10 21:29:01 volumio volumio[671]: info: ------------------------------ 370ms Apr 10 21:29:04 volumio volumio[671]: info: CoreCommandRouter::volumioGetState Apr 10 21:29:04 volumio volumio[671]: info: CorePlayQueue::getTrack 0 Apr 10 21:29:22 volumio ntpd[639]: Soliciting pool server 2001:ac8:7d:42:0:2:0:20 Apr 10 21:29:45 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 21:29:45 volumio volumio[671]: info: CURURI: playlists Apr 10 21:29:45 volumio volumio[671]: info: Listing playlists Apr 10 21:29:45 volumio volumio[671]: info: Preload queue cleared Apr 10 21:29:50 volumio volumio[671]: info: Preload queue cleared Apr 10 21:29:53 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 21:29:53 volumio volumio[671]: info: CURURI: artists:// Apr 10 21:29:53 volumio volumio[671]: info: Preload queue cleared Apr 10 21:30:07 volumio volumio[671]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 10 21:30:07 volumio volumio[671]: info: CURURI: albums:// Apr 10 21:30:07 volumio volumio[671]: info: listAlbums - loading Albums from cache Apr 10 21:30:07 volumio volumio[671]: info: Preload queue cleared Apr 10 21:30:10 volumio volumio[671]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 21:30:10 volumio volumio[671]: TypeError: Cannot read property 'slice' of null Apr 10 21:30:10 volumio volumio[671]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Apr 10 21:30:10 volumio volumio[671]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Apr 10 21:30:10 volumio volumio[671]: at Object.onceWrapper (events.js:422:26) Apr 10 21:30:10 volumio volumio[671]: at ClientRequest.emit (events.js:315:20) Apr 10 21:30:10 volumio volumio[671]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Apr 10 21:30:10 volumio volumio[671]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Apr 10 21:30:10 volumio volumio[671]: at TLSSocket.socketOnData (_http_client.js:509:22) Apr 10 21:30:10 volumio volumio[671]: at TLSSocket.emit (events.js:315:20) Apr 10 21:30:10 volumio volumio[671]: at addChunk (internal/streams/readable.js:309:12) Apr 10 21:30:10 volumio volumio[671]: at readableAddChunk (internal/streams/readable.js:284:9) Apr 10 21:30:10 volumio volumio[671]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Apr 10 21:30:10 volumio volumio[671]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Apr 10 21:30:10 volumio volumio[671]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 10 21:30:11 volumio sudo[10567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-10 21:29 Apr 10 21:30:11 volumio sudo[10567]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"