-- Logs begin at Sun 2025-10-26 10:50:47 UTC, end at Fri 2025-10-31 16:16:58 UTC. -- Oct 31 16:16:34 volumio volumio[811]: info: CoreCommandRouter::volumioGetState Oct 31 16:16:34 volumio volumio[811]: info: CorePlayQueue::getTrack 10 Oct 31 16:16:34 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 31 16:16:34 volumio volumio[811]: info: Listing playlists Oct 31 16:16:34 volumio volumio[811]: info: CoreCommandRouter::volumioGetVisibleSources Oct 31 16:16:34 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 16:16:34 volumio volumio[811]: info: CoreCommandRouter::volumioGetQueue Oct 31 16:16:34 volumio volumio[811]: info: CoreStateMachine::getQueue Oct 31 16:16:34 volumio volumio[811]: info: CorePlayQueue::getQueue Oct 31 16:16:43 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 31 16:16:43 volumio volumio[811]: info: CURURI: playlists Oct 31 16:16:43 volumio volumio[811]: info: Listing playlists Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::ClearQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::stop Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 16:16:48 volumio volumio[811]: UNSET VOLATILE Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::stPlaybackTimer Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::updateTrackBlock Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrackBlock Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 10 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::serviceStop Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 10 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::serviceStop Oct 31 16:16:48 volumio volumio[811]: info: ControllerMpd::stop Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand stop Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::clearPlayQueue Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::saveQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushQueue Oct 31 16:16:48 volumio volumio[811]: info: Play playlist TMix Feel It Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioClearQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::ClearQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::stop Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 16:16:48 volumio volumio[811]: UNSET VOLATILE Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::clearPlayQueue Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::saveQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioAddQueueItems Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::addQueueItems Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::addQueueItems Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Sade/Soldier of Love/02 Soldier of Love.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Sade/Soldier of Love/02 Soldier of Love.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Muse/Black Holes and Revelations/02 Starlight.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Muse/Black Holes and Revelations/02 Starlight.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/James Blake/James Blake/06 Limit to Your Love.m4a Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/James Blake/James Blake/06 Limit to Your Love.m4a in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Depeche Mode/Enjoy the Silence/04 Memphisto.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Depeche Mode/Enjoy the Silence/04 Memphisto.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Massive Attack/Mezzanine/07 Man Next Door.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Massive Attack/Mezzanine/07 Man Next Door.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Peter Fox/Stadtaffe/05 Das zweite Gesicht.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Peter Fox/Stadtaffe/05 Das zweite Gesicht.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Kraftwerk/Die Mensch-Maschine/02 Spacelab.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Kraftwerk/Die Mensch-Maschine/02 Spacelab.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Mitra Mitra/mitra mitra/07_Indecisive Split Decision.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Mitra Mitra/mitra mitra/07_Indecisive Split Decision.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Billie Eilish/When we all fall asleep, where do we go/01-02-Billie_Eilish-bad_guy-LLS.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Billie Eilish/When we all fall asleep, where do we go/01-02-Billie_Eilish-bad_guy-LLS.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Jeans For Jesus/Jeans for Jesus/06 Jeans for Jesus.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Jeans For Jesus/Jeans for Jesus/06 Jeans for Jesus.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Marla Glen/This Is Marla Glen/01 The Cost Of Freedom.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Marla Glen/This Is Marla Glen/01 The Cost Of Freedom.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Yello/Yello by Yello - Anthology/30 Ciel Ouvert.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Yello/Yello by Yello - Anthology/30 Ciel Ouvert.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Massive Attack/Protection/09 Heat Miser.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Massive Attack/Protection/09 Heat Miser.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Sono/Solid State/02 2000 Guns.flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Sono/Solid State/02 2000 Guns.flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Adding Item to queue: mnt/USB/MUSIC___/Yello/Yello by Yello - Anthology/12 Time Palace (feat. Jade Davies).flac Oct 31 16:16:48 volumio volumio[811]: info: Exploding uri mnt/USB/MUSIC___/Yello/Yello by Yello - Anthology/12 Time Palace (feat. Jade Davies).flac in service mpd Oct 31 16:16:48 volumio volumio[811]: info: Oct 31 16:16:48 volumio volumio[811]: ---------------------------- MPD announces state update: player Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FVarious%20Artists%2FSnippet%20Collection%2FFeel%20It%20Snippet.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FSade%2FSoldier%20of%20Love%2F02%20Soldier%20of%20Love.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Sade/Soldier of Love/02 Soldier of Love.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FMuse%2FBlack%20Holes%20and%20Revelations%2F02%20Starlight.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Muse/Black Holes and Revelations/02 Starlight.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FJames%20Blake%2FJames%20Blake%2F06%20Limit%20to%20Your%20Love.m4a&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/James Blake/James Blake/06 Limit to Your Love.m4a Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FDepeche%20Mode%2FEnjoy%20the%20Silence%2F04%20Memphisto.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Depeche Mode/Enjoy the Silence/04 Memphisto.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FMassive%20Attack%2FMezzanine%2F07%20Man%20Next%20Door.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Massive Attack/Mezzanine/07 Man Next Door.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FPeter%20Fox%2FStadtaffe%2F05%20Das%20zweite%20Gesicht.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Peter Fox/Stadtaffe/05 Das zweite Gesicht.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FKraftwerk%2FDie%20Mensch-Maschine%2F02%20Spacelab.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Kraftwerk/Die Mensch-Maschine/02 Spacelab.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FMitra%20Mitra%2Fmitra%20mitra%2F07_Indecisive%20Split%20Decision.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Mitra Mitra/mitra mitra/07_Indecisive Split Decision.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FBillie%20Eilish%2FWhen%20we%20all%20fall%20asleep%2C%20where%20do%20we%20go%2F01-02-Billie_Eilish-bad_guy-LLS.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Billie Eilish/When we all fall asleep, where do we go/01-02-Billie_Eilish-bad_guy-LLS.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FJeans%20For%20Jesus%2FJeans%20for%20Jesus%2F06%20Jeans%20for%20Jesus.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Jeans For Jesus/Jeans for Jesus/06 Jeans for Jesus.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FMarla%20Glen%2FThis%20Is%20Marla%20Glen%2F01%20The%20Cost%20Of%20Freedom.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Marla Glen/This Is Marla Glen/01 The Cost Of Freedom.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FYello%2FYello%20by%20Yello%20-%20Anthology%2F30%20Ciel%20Ouvert.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Yello/Yello by Yello - Anthology/30 Ciel Ouvert.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FMassive%20Attack%2FProtection%2F09%20Heat%20Miser.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Massive Attack/Protection/09 Heat Miser.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FSono%2FSolid%20State%2F02%202000%20Guns.flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Sono/Solid State/02 2000 Guns.flac Oct 31 16:16:48 volumio volumio[811]: info: ALBUMART /albumart?cacheid=317&path=%2Fmnt%2FUSB%2FMUSIC___%2FYello%2FYello%20by%20Yello%20-%20Anthology%2F12%20Time%20Palace%20(feat.%20Jade%20Davies).flac&metadata=false Oct 31 16:16:48 volumio volumio[811]: info: URI /mnt/USB/MUSIC___/Yello/Yello by Yello - Anthology/12 Time Palace (feat. Jade Davies).flac Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand stop took 211 milliseconds Oct 31 16:16:48 volumio volumio[811]: info: ControllerMpd::getState Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::saveQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushQueue Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::updateTrackBlock Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrackBlock Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPlay Oct 31 16:16:48 volumio volumio[811]: UNSET VOLATILE Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::play index 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::stop Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 16:16:48 volumio volumio[811]: UNSET VOLATILE Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::play index undefined Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::startPlaybackTimer Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::clearAddPlayTracks USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand stop Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand status took 50 milliseconds Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand stop took 10 milliseconds Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::parseState Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand clear Oct 31 16:16:48 volumio volumio[811]: info: Oct 31 16:16:48 volumio volumio[811]: ---------------------------- MPD announces system playlist update Oct 31 16:16:48 volumio volumio[811]: info: Ignoring MPD Status Update Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand playlistinfo took 20 milliseconds Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand clear took 19 milliseconds Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac" Oct 31 16:16:48 volumio volumio[811]: info: ControllerMpd::pushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::servicePushState Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: 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":"Bohemian Rhapsody","artist":"Queen","album":"A Night at the Opera","uri":"USB/MUSIC___/Queen/A Night at the Opera/11 Bohemian Rhapsody.flac","trackType":"flac"} Oct 31 16:16:48 volumio volumio[811]: verbose: CURRENT POSITION 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::syncState stateService stop Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus stop Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: No code Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: ------------------------------ 193ms Oct 31 16:16:48 volumio volumio[811]: error: updateQueue error: null Oct 31 16:16:48 volumio volumio[811]: info: Oct 31 16:16:48 volumio volumio[811]: ---------------------------- MPD announces system playlist update Oct 31 16:16:48 volumio volumio[811]: info: Ignoring MPD Status Update Oct 31 16:16:48 volumio volumio[811]: info: ------------------------------ 93ms Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand add "USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac" took 83 milliseconds Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand play Oct 31 16:16:48 volumio volumio[811]: info: ------------------------------ 20ms Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand play took 16 milliseconds Oct 31 16:16:48 volumio volumio[811]: info: Oct 31 16:16:48 volumio volumio[811]: ---------------------------- MPD announces state update: player Oct 31 16:16:48 volumio volumio[811]: info: ControllerMpd::getState Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Oct 31 16:16:48 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand status took 13 milliseconds Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::parseState Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 31 16:16:48 volumio volumio[811]: info: Oct 31 16:16:48 volumio volumio[811]: ---------------------------- MPD announces state update: player Oct 31 16:16:48 volumio volumio[811]: info: ControllerMpd::getState Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand status took 5 milliseconds Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::parseState Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 31 16:16:48 volumio volumio[811]: info: ControllerMpd::pushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::servicePushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":7,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Feel It Snippet","artist":"James Blake","album":"Snippet Collection","uri":"USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac","trackType":"flac"} Oct 31 16:16:48 volumio volumio[811]: verbose: CURRENT POSITION 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::syncState stateService play Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus stop Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: ------------------------------ 59ms Oct 31 16:16:48 volumio volumio[811]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 31 16:16:48 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Oct 31 16:16:48 volumio volumio[811]: info: ControllerMpd::pushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::servicePushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":7,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"829 Kbps","isStreaming":false,"title":"Feel It Snippet","artist":"James Blake","album":"Snippet Collection","uri":"USB/MUSIC___/Various Artists/Snippet Collection/Feel It Snippet.flac","trackType":"flac"} Oct 31 16:16:48 volumio volumio[811]: verbose: CURRENT POSITION 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::syncState stateService play Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus play Oct 31 16:16:48 volumio volumio[811]: info: Received an update from plugin. extracting info from payload Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:48 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:48 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:48 volumio volumio[811]: info: ------------------------------ 86ms Oct 31 16:16:50 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:50 volumio volumio[811]: info: CorePlayQueue::getTrack 1 Oct 31 16:16:50 volumio volumio[811]: info: Prefetching next song Oct 31 16:16:50 volumio volumio[811]: info: DOING PREFETCH IN MPD Oct 31 16:16:50 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand add "USB/MUSIC___/Sade/Soldier of Love/02 Soldier of Love.flac" Oct 31 16:16:50 volumio volumio[811]: info: Oct 31 16:16:50 volumio volumio[811]: ---------------------------- MPD announces system playlist update Oct 31 16:16:50 volumio volumio[811]: info: Ignoring MPD Status Update Oct 31 16:16:50 volumio volumio[811]: info: sendMpdCommand add "USB/MUSIC___/Sade/Soldier of Love/02 Soldier of Love.flac" took 5 milliseconds Oct 31 16:16:50 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand consume 1 Oct 31 16:16:50 volumio volumio[811]: info: ------------------------------ 24ms Oct 31 16:16:50 volumio volumio[811]: info: sendMpdCommand consume 1 took 20 milliseconds Oct 31 16:16:52 volumio volumio[811]: info: CoreCommandRouter::volumioRandom Oct 31 16:16:52 volumio volumio[811]: info: CoreCommandRouter::writePlayerControls Oct 31 16:16:52 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:52 volumio volumio[811]: info: CoreStateMachine::setRandom true Oct 31 16:16:52 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:52 volumio volumio[811]: info: CorePlayQueue::getTrack 0 Oct 31 16:16:52 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:52 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:54 volumio volumio[811]: info: CoreStateMachine::startPlaybackTimer Oct 31 16:16:54 volumio volumio[811]: info: CorePlayQueue::getTrack undefined Oct 31 16:16:55 volumio volumio[811]: info: Oct 31 16:16:55 volumio volumio[811]: ---------------------------- MPD announces system playlist update Oct 31 16:16:55 volumio volumio[811]: info: Ignoring MPD Status Update Oct 31 16:16:55 volumio volumio[811]: info: Oct 31 16:16:55 volumio volumio[811]: ---------------------------- MPD announces state update: player Oct 31 16:16:55 volumio volumio[811]: info: ControllerMpd::getState Oct 31 16:16:55 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand status Oct 31 16:16:55 volumio volumio[811]: info: ------------------------------ 7ms Oct 31 16:16:55 volumio volumio[811]: info: sendMpdCommand status took 4 milliseconds Oct 31 16:16:55 volumio volumio[811]: verbose: ControllerMpd::parseState Oct 31 16:16:55 volumio volumio[811]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 31 16:16:55 volumio volumio[811]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 31 16:16:55 volumio volumio[811]: verbose: ControllerMpd::parseTrackInfo Oct 31 16:16:55 volumio volumio[811]: info: ControllerMpd::pushState Oct 31 16:16:55 volumio volumio[811]: info: CoreCommandRouter::servicePushState Oct 31 16:16:55 volumio volumio[811]: info: CorePlayQueue::getTrack undefined Oct 31 16:16:55 volumio volumio[811]: verbose: STATE SERVICE {"status":"play","position":0,"seek":23,"duration":359,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"459 Kbps","isStreaming":false,"title":"Soldier of Love","artist":"Sade","album":"Soldier of Love","uri":"USB/MUSIC___/Sade/Soldier of Love/02 Soldier of Love.flac","trackType":"flac"} Oct 31 16:16:55 volumio volumio[811]: verbose: CURRENT POSITION undefined Oct 31 16:16:55 volumio volumio[811]: info: CoreStateMachine::syncState stateService play Oct 31 16:16:55 volumio volumio[811]: info: CoreStateMachine::syncState currentStatus play Oct 31 16:16:55 volumio volumio[811]: info: Received an update from plugin. extracting info from payload Oct 31 16:16:55 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:55 volumio volumio[811]: info: CorePlayQueue::getTrack undefined Oct 31 16:16:55 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:55 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:55 volumio volumio[811]: info: CoreStateMachine::pushState Oct 31 16:16:55 volumio volumio[811]: info: CorePlayQueue::getTrack undefined Oct 31 16:16:55 volumio volumio[811]: info: CoreCommandRouter::volumioPushState Oct 31 16:16:55 volumio volumio[811]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 31 16:16:55 volumio volumio[811]: info: ------------------------------ 55ms Oct 31 16:16:57 volumio volumio[811]: info: CorePlayQueue::getTrack undefined Oct 31 16:16:57 volumio volumio[811]: info: CorePlayQueue::getTrack 7 Oct 31 16:16:57 volumio volumio[811]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 16:16:57 volumio volumio[811]: TypeError: Cannot read property 'service' of undefined Oct 31 16:16:57 volumio volumio[811]: at CoreStateMachine.increasePlaybackTimer (/volumio/app/statemachine.js:421:107) Oct 31 16:16:57 volumio volumio[811]: at ontimeout (timers.js:482:11) Oct 31 16:16:57 volumio volumio[811]: at tryOnTimeout (timers.js:317:5) Oct 31 16:16:57 volumio volumio[811]: at Timer.listOnTimeout (timers.js:277:5) Oct 31 16:16:57 volumio volumio[811]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 16:16:58 volumio sudo[2695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-31 16:15 Oct 31 16:16:58 volumio sudo[2695]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="77db3ca2a7f5a7023ece8c5b86e997d58abdace6" VOLUMIO_BE_VERSION="748352701ebc6ec2b59443fcac1ec9aea1f276df" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Jul 2 12:45:33 CEST 2021" VOLUMIO_VERSION="2.907" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="858e764292794952fe9c14f4c1868f5a"