Jun 03 00:04:20 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 03 00:04:20 volumio volumio[1293]: info: CURURI: music-library/USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes} Jun 03 00:04:20 volumio volumio[1293]: info: Preload queue cleared Jun 03 00:04:20 volumio volumio[1293]: info: Preloading song: music-library/USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/Sings The Blues.m3u Jun 03 00:04:20 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/Sings The Blues.m3u in service mpd Jun 03 00:04:20 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Jun 03 00:04:20 volumio volumio[1293]: info: CorePlayQueue::getTrack 1 Jun 03 00:04:20 volumio volumio[1293]: info: Prefetching next song Jun 03 00:04:20 volumio volumio[1293]: info: DOING PREFETCH IN MPD Jun 03 00:04:20 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand add "USB/Musica/NuevaMusicaEscucharFiltroEntrada/lespecial2026-04-03/02 Recidivism.flac" Jun 03 00:04:20 volumio volumio[1293]: info: Jun 03 00:04:20 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:20 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:20 volumio volumio[1293]: info: sendMpdCommand add "USB/Musica/NuevaMusicaEscucharFiltroEntrada/lespecial2026-04-03/02 Recidivism.flac" took 1 milliseconds Jun 03 00:04:20 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand consume 1 Jun 03 00:04:20 volumio volumio[1293]: info: Jun 03 00:04:20 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:20 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:20 volumio volumio[1293]: info: Jun 03 00:04:20 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:20 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:20 volumio volumio[1293]: info: ------------------------------ 2ms Jun 03 00:04:20 volumio volumio[1293]: info: sendMpdCommand consume 1 took 1 milliseconds Jun 03 00:04:20 volumio volumio[1293]: info: ------------------------------ 1ms Jun 03 00:04:20 volumio volumio[1293]: info: ------------------------------ 1ms Jun 03 00:04:23 volumio volumio[1293]: info: Preload queue cleared Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: [1780437863207] ---------------------------- Client requests add and Play Volumio CUE entry Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Jun 03 00:04:23 volumio volumio[1293]: info: Adding CUE individual entry: 0 USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/Sings The Blues.cue Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioAddQueueItems Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::addQueueItems Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::addQueueItems Jun 03 00:04:23 volumio volumio[1293]: info: Preload queue cleared Jun 03 00:04:23 volumio volumio[1293]: info: Adding Item to queue: cue://USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/Sings The Blues.cue@0 Jun 03 00:04:23 volumio volumio[1293]: info: Exploding uri cue://USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/Sings The Blues.cue@0 in service mpd Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPlay Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::play index 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::stop Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::stPlaybackTimer Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::updateTrackBlock Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrackBlock Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::serviceStop Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 0 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::serviceStop Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::stop Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushQueue Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::saveQueue Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::updateTrackBlock Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrackBlock Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand stop took 6 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::play index undefined Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::startPlaybackTimer Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 4 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand stop took 3 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 1 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 0 milliseconds Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand clear Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:23 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand clear took 1 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand load "USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/Sings The Blues.cue" Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::servicePushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: 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":"Intro —>","artist":"lespecial","album":"Telefunken M62 & Digital Soundboard","uri":"USB/Musica/NuevaMusicaEscucharFiltroEntrada/lespecial2026-04-03/01 Intro.flac","trackType":"flac"} Jun 03 00:04:23 volumio volumio[1293]: verbose: CURRENT POSITION 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState stateService stop Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState currentStatus stop Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: No code Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 03 00:04:23 volumio volumio[1293]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 10ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 8ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 8ms Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:23 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:23 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:23 volumio volumio[1293]: error: updateQueue error: null Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:23 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 7ms Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand load "USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/Sings The Blues.cue" took 8 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 2ms Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand play Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:23 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces system playlist update Jun 03 00:04:23 volumio volumio[1293]: info: Ignoring MPD Status Update Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 4ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 3ms Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand play took 2 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 3ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 3ms Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 2 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: Jun 03 00:04:23 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::getState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand status Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 3 milliseconds Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 5 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 4 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 3 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 3 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand status took 3 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseState Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::servicePushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":165,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Do I Move You","artist":"Nina Simone","album":"Sings The Blues","uri":"USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/A1 - Do I Move You.flac","trackType":"flac"} Jun 03 00:04:23 volumio volumio[1293]: verbose: CURRENT POSITION 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState stateService play Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState currentStatus stop Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::servicePushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":165,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Do I Move You","artist":"Nina Simone","album":"Sings The Blues","uri":"USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/A1 - Do I Move You.flac","trackType":"flac"} Jun 03 00:04:23 volumio volumio[1293]: verbose: CURRENT POSITION 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState stateService play Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState currentStatus play Jun 03 00:04:23 volumio volumio[1293]: info: Received an update from plugin. extracting info from payload Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 12ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 11ms Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 03 00:04:23 volumio volumio[1293]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: verbose: ControllerMpd::parseTrackInfo Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::servicePushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":165,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Do I Move You","artist":"Nina Simone","album":"Sings The Blues","uri":"USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/A1 - Do I Move You.flac","trackType":"flac"} Jun 03 00:04:23 volumio volumio[1293]: verbose: CURRENT POSITION 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState stateService play Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState currentStatus play Jun 03 00:04:23 volumio volumio[1293]: info: Received an update from plugin. extracting info from payload Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::servicePushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":165,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Do I Move You","artist":"Nina Simone","album":"Sings The Blues","uri":"USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/A1 - Do I Move You.flac","trackType":"flac"} Jun 03 00:04:23 volumio volumio[1293]: verbose: CURRENT POSITION 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState stateService play Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState currentStatus play Jun 03 00:04:23 volumio volumio[1293]: info: Received an update from plugin. extracting info from payload Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::servicePushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":165,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Do I Move You","artist":"Nina Simone","album":"Sings The Blues","uri":"USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/A1 - Do I Move You.flac","trackType":"flac"} Jun 03 00:04:23 volumio volumio[1293]: verbose: CURRENT POSITION 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState stateService play Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState currentStatus play Jun 03 00:04:23 volumio volumio[1293]: info: Received an update from plugin. extracting info from payload Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: ControllerMpd::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::servicePushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":165,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Do I Move You","artist":"Nina Simone","album":"Sings The Blues","uri":"USB/Musica/Flac/Nina Simone - Sings the Blues (1967) [flac] {Speakers Corner 180g LP; HiRes}/A1 - Do I Move You.flac","trackType":"flac"} Jun 03 00:04:23 volumio volumio[1293]: verbose: CURRENT POSITION 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState stateService play Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::syncState currentStatus play Jun 03 00:04:23 volumio volumio[1293]: info: Received an update from plugin. extracting info from payload Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:04:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:04:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 23ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 22ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 20ms Jun 03 00:04:23 volumio volumio[1293]: info: ------------------------------ 20ms Jun 03 00:05:23 volumio volumio[1293]: info: Preload queue cleared Jun 03 00:05:23 volumio volumio[1293]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::ClearQueue Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::stop Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::stPlaybackTimer Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::updateTrackBlock Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::getTrackBlock Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::pushState Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:05:23 volumio volumio[1293]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:05:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::serviceStop Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::getTrack 17 Jun 03 00:05:23 volumio volumio[1293]: info: CoreCommandRouter::serviceStop Jun 03 00:05:23 volumio volumio[1293]: info: ControllerMpd::stop Jun 03 00:05:23 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::clearPlayQueue Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::saveQueue Jun 03 00:05:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushQueue Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::addQueueItems Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::addQueueItems Jun 03 00:05:23 volumio volumio[1293]: info: Preload queue cleared Jun 03 00:05:23 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 Jun 03 00:05:23 volumio volumio[1293]: info: Using cached record of: music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 Jun 03 00:05:23 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/MendelssohnVC24.flac Jun 03 00:05:23 volumio volumio[1293]: info: Using cached record of: music-library/USB/Musica/MendelssohnVC24.flac Jun 03 00:05:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPushQueue Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::saveQueue Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::updateTrackBlock Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::getTrackBlock Jun 03 00:05:23 volumio volumio[1293]: info: CoreCommandRouter::volumioPlay Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::play index 1 Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:23 volumio volumio[1293]: info: CoreStateMachine::addQueueItems Jun 03 00:05:23 volumio volumio[1293]: info: CorePlayQueue::addQueueItems Jun 03 00:05:23 volumio volumio[1293]: info: Preload queue cleared Jun 03 00:05:23 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Flac Jun 03 00:05:23 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Flac in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/M.Vanessa.Paradis.Un.Monstre.A.Paris.(A.Monster.In.Paris).Soundtrack.2011 Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/M.Vanessa.Paradis.Un.Monstre.A.Paris.(A.Monster.In.Paris).Soundtrack.2011 in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Mélanie Laurent - En T'attendant (Feat. Damien Rice)(2011)(FLAC) Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Mélanie Laurent - En T'attendant (Feat. Damien Rice)(2011)(FLAC) in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/mp3_wma_ogg Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/mp3_wma_ogg in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/NuevaMusicaEscucharFiltroEntrada Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/NuevaMusicaEscucharFiltroEntrada in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/The National - The Virginia EP [2008] Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/The National - The Virginia EP [2008] in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis - Divinidylle Tour (2008) - Chanson [www.torrentazos.com] Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis - Divinidylle Tour (2008) - Chanson [www.torrentazos.com] in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis - Love Songs 2013 Pop 2CD Limited Edition 320kbps CBR MP3 [VX] Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis - Love Songs 2013 Pop 2CD Limited Edition 320kbps CBR MP3 [VX] in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis - M & J (1988) [FLAC (img+cue)] Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis - M & J (1988) [FLAC (img+cue)] in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis -- Divinidylle Tour Live [FLAC] Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis -- Divinidylle Tour Live [FLAC] in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis Best of 2009 Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis Best of 2009 in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis_-_Love Songs (Limited Edition) (2013)[Mp3][www.lokotorrents.com] Jun 03 00:05:24 volumio volumio[1293]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis_-_Love Songs (Limited Edition) (2013)[Mp3][www.lokotorrents.com] in service mpd Jun 03 00:05:24 volumio volumio[1293]: info: CoreStateMachine::stop Jun 03 00:05:24 volumio volumio[1293]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:24 volumio volumio[1293]: info: CoreStateMachine::play index undefined Jun 03 00:05:24 volumio volumio[1293]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:24 volumio volumio[1293]: info: CorePlayQueue::getTrack 1 Jun 03 00:05:24 volumio volumio[1293]: info: CoreStateMachine::startPlaybackTimer Jun 03 00:05:24 volumio volumio[1293]: info: CorePlayQueue::getTrack 1 Jun 03 00:05:24 volumio volumio[1293]: verbose: ControllerMpd::clearAddPlayTracks USB/Musica/MendelssohnVC24.flac Jun 03 00:05:24 volumio volumio[1293]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 00:05:24 volumio volumio[1293]: info: Jun 03 00:05:24 volumio volumio[1293]: ---------------------------- MPD announces state update: player Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA1%20-%20Rolling%20In%20The%20Deep.flac&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A1 - Rolling In The Deep.flac Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA2%20-%20Rumour%20Has%20It.flac&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A2 - Rumour Has It.flac Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA3%20-%20Turning%20Tables.flac&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A3 - Turning Tables.flac Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA4%20-%20Don't%20You%20Remember.flac&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A4 - Don't You Remember.flac Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA5%20-%20Set%20Fire%20To%20The%20Rain.flac&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A5 - Set Fire To The Rain.flac Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA6%20-%20He%20Won't%20Go.flac&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A6 - He Won't Go.flac Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FAdele%20-%2021.cue&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/Adele - 21.cue Jun 03 00:05:24 volumio volumio[1293]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FAdele%20-%2021.cue&metadata=false Jun 03 00:05:24 volumio volumio[1293]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/Adele - 21.cue Jun 03 00:05:24 volumio volumio[1293]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:24 volumio volumio[1293]: Error: Unable to resolve or reject the same promise twice Jun 03 00:05:24 volumio volumio[1293]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 03 00:05:24 volumio volumio[1293]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Jun 03 00:05:24 volumio volumio[1293]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jun 03 00:05:24 volumio volumio[1293]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jun 03 00:05:24 volumio volumio[1293]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jun 03 00:05:24 volumio volumio[1293]: at Socket.emit (node:events:514:28) Jun 03 00:05:24 volumio volumio[1293]: at addChunk (node:internal/streams/readable:343:12) Jun 03 00:05:24 volumio volumio[1293]: at readableAddChunk (node:internal/streams/readable:312:11) Jun 03 00:05:24 volumio volumio[1293]: at Readable.push (node:internal/streams/readable:253:10) Jun 03 00:05:24 volumio volumio[1293]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jun 03 00:05:24 volumio volumio[1293]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:24 volumio sudo[14808]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-03 00:04' Jun 03 00:05:24 volumio sudo[14808]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:24 volumio sudo[14808]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:25 volumio volumio-remote-updater[998]: [2026-06-03 00:05:25] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 03 00:05:25 volumio volumio-remote-updater[998]: [2026-06-03 00:05:25] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 03 00:05:25 volumio volumio5-onboarding[1523]: time=2026-06-03T00:05:25.197+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Jun 03 00:05:25 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 03 00:05:25 volumio volumio5-onboarding[1523]: time=2026-06-03T00:05:25.198+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Jun 03 00:05:25 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 03 00:05:25 volumio systemd[1]: volumio.service: Consumed 1min 20.976s CPU time. Jun 03 00:05:25 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Jun 03 00:05:25 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Jun 03 00:05:25 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jun 03 00:05:25 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Jun 03 00:05:25 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Jun 03 00:05:25 volumio systemd[1]: volumio.service: Consumed 1min 20.976s CPU time. Jun 03 00:05:25 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Jun 03 00:05:25 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Jun 03 00:05:26 volumio volumio[14848]: info: ------------------------------------------- Jun 03 00:05:26 volumio volumio[14848]: info: ----- Volumio3 ---- Jun 03 00:05:26 volumio volumio[14848]: info: ------------------------------------------- Jun 03 00:05:26 volumio volumio[14848]: info: ----- System startup ---- Jun 03 00:05:26 volumio volumio[14848]: info: ------------------------------------------- Jun 03 00:05:26 volumio volumio[14848]: info: MYVOLUMIO Environment detected Jun 03 00:05:26 volumio volumio[14848]: info: Plugin folders cleanup Jun 03 00:05:26 volumio volumio[14848]: info: Scanning into folder /volumio/app/plugins/ Jun 03 00:05:26 volumio volumio[14848]: info: Scanning category audio_interface Jun 03 00:05:26 volumio volumio[14848]: info: Scanning category miscellanea Jun 03 00:05:26 volumio volumio[14848]: info: Scanning category music_service Jun 03 00:05:26 volumio volumio[14848]: info: Scanning category plugins.json Jun 03 00:05:26 volumio volumio[14848]: info: Scanning category system_controller Jun 03 00:05:26 volumio volumio[14848]: info: Scanning category user_interface Jun 03 00:05:26 volumio volumio[14848]: info: Scanning into folder /data/plugins/ Jun 03 00:05:26 volumio volumio[14848]: info: Scanning category system_controller Jun 03 00:05:26 volumio volumio[14848]: info: Plugin folders cleanup completed Jun 03 00:05:26 volumio volumio[14848]: info: ------------------------------------------- Jun 03 00:05:26 volumio volumio[14848]: info: ----- Core plugins startup ---- Jun 03 00:05:26 volumio volumio[14848]: info: ------------------------------------------- Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugins from folder /volumio/app/plugins/ Jun 03 00:05:26 volumio volumio[14848]: info: Adding plugin upnp to MyMusic Plugins Jun 03 00:05:26 volumio volumio[14848]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 03 00:05:26 volumio volumio[14848]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugins from folder /data/plugins/ Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "system"... Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "appearance"... Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "network"... Jun 03 00:05:26 volumio volumio[14848]: info: Refreshing Cached IP Addresses Jun 03 00:05:26 volumio sudo[14876]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 00:05:26 volumio sudo[14876]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:26 volumio sudo[14878]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 00:05:26 volumio sudo[14878]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:26 volumio sudo[14876]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "services"... Jun 03 00:05:26 volumio sudo[14878]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "volumio5onboarding"... Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "alsa_controller"... Jun 03 00:05:26 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "wizard"... Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "networkfs"... Jun 03 00:05:26 volumio volumio[14848]: info: Starting Udev Watcher for removable devices Jun 03 00:05:26 volumio sudo[14904]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nmt,password=1234,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,ro,dir_mode=0777,file_mode=0777,vers=1.0 //192.168.1.6/share /mnt/NAS/PopCorn Jun 03 00:05:26 volumio sudo[14904]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:26 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 03 00:05:26 volumio kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 03 00:05:26 volumio kernel: CIFS: Attempting to mount //192.168.1.6/share Jun 03 00:05:26 volumio volumio[14848]: info: Mounting Device EFI Jun 03 00:05:26 volumio sudo[14914]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 00:05:26 volumio sudo[14914]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:26 volumio sudo[14914]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:26 volumio volumio[14848]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Jun 03 00:05:26 volumio volumio[14848]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:26 volumio volumio[14848]: error: Failed to mount EFI: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/EFI" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 00:05:26 volumio volumio[14848]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Jun 03 00:05:26 volumio volumio[14848]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:26 volumio volumio[14848]: info: Mounting Device Musica Jun 03 00:05:26 volumio sudo[14922]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Musica -o noatime Jun 03 00:05:26 volumio sudo[14922]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:26 volumio sudo[14922]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:26 volumio volumio[14848]: mount: /media/Musica: /dev/sda2 already mounted on /media/Musica. Jun 03 00:05:26 volumio volumio[14848]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:26 volumio volumio[14848]: error: Failed to mount Musica: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/Musica" -o noatime Jun 03 00:05:26 volumio volumio[14848]: mount: /media/Musica: /dev/sda2 already mounted on /media/Musica. Jun 03 00:05:26 volumio volumio[14848]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:26 volumio volumio[14848]: info: Ignoring mount for partition: boot Jun 03 00:05:26 volumio volumio[14848]: info: Ignoring mount for partition: volumio Jun 03 00:05:26 volumio volumio[14848]: info: Ignoring mount for partition: volumio_data Jun 03 00:05:26 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "volumio_command_line_client"... Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "upnp"... Jun 03 00:05:26 volumio volumio[14848]: info: [1780437926888] Starting Upmpd Daemon Jun 03 00:05:26 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "my_music"... Jun 03 00:05:26 volumio volumio[14848]: info: Loading plugin "mpd"... Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "upnp_browser"... Jun 03 00:05:27 volumio volumio[14848]: info: Starting UPNP Browser Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "alarm-clock"... Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "airplay_emulation"... Jun 03 00:05:27 volumio volumio[14848]: info: Starting Shairport Sync Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "last_100"... Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "webradio"... Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "i2s_dacs"... Jun 03 00:05:27 volumio volumio[14848]: info: I2S DAC not set, start Auto-detection Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "volumiodiscovery"... Jun 03 00:05:27 volumio volumio[14848]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:27 volumio volumio[14848]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:27 volumio volumio[14848]: *** WARNING *** For more information see Jun 03 00:05:27 volumio volumio[14848]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:27 volumio volumio[14848]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:27 volumio volumio[14848]: *** WARNING *** For more information see Jun 03 00:05:27 volumio node[14848]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:27 volumio node[14848]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:27 volumio node[14848]: *** WARNING *** For more information see Jun 03 00:05:27 volumio node[14848]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:27 volumio node[14848]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:27 volumio node[14848]: *** WARNING *** For more information see Jun 03 00:05:27 volumio volumio[14848]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 03 00:05:27 volumio volumio[14848]: info: Discovery: Started advertising with name: Volumio Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "outputs"... Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "albumart"... Jun 03 00:05:27 volumio volumio[14848]: info: Plugin example_plugin is not enabled Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "inputs"... Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "updater_comm"... Jun 03 00:05:27 volumio volumio[14848]: info: Plugin mpdemulation is not enabled Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "rest_api"... Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "websocket"... Jun 03 00:05:27 volumio volumio[14848]: info: Starting Socket.io Server version 1.7.4 Jun 03 00:05:27 volumio volumio[14848]: info: Loading plugin "rpi_eeprom_config"... Jun 03 00:05:27 volumio volumio[14848]: info: Applying required configuration parameters for plugin rpi_eeprom_config Jun 03 00:05:27 volumio volumio[14926]: Forking 3 albumart workers Jun 03 00:05:27 volumio volumio[14848]: info: [RpiEepromConfig] Hardware capabilities loaded Jun 03 00:05:27 volumio volumio[14848]: info: Loading i18n strings for locale es Jun 03 00:05:27 volumio volumio[14848]: Updating browse sources language Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::initPlayerControls Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: Express server listening on port 3000 Jun 03 00:05:27 volumio volumio[14848]: [Metrics] WebUI: 1s 652.95ms Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::resetVolumioState Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::getcurrentVolume Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioRetrievevolume Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::pushState Jun 03 00:05:27 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:27 volumio volumio[14848]: info: Volumio Network Manager: Network status updated: 1 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.63 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 1 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: info: Cannot read play queue from file Jun 03 00:05:27 volumio volumio[14848]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 03 00:05:27 volumio volumio[14848]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Jun 03 00:05:27 volumio volumio[14848]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::setRepeat false single undefined Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::pushState Jun 03 00:05:27 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::setRandom null Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::pushState Jun 03 00:05:27 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: info: Setting Device type: Raspberry PI Jun 03 00:05:27 volumio volumio[14938]: Starting albumart workers Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14937]: Starting albumart workers Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14936]: Starting albumart workers Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.63 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 2 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioGetVisibleSources Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:27 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioGetQueue Jun 03 00:05:27 volumio volumio[14848]: info: CoreStateMachine::getQueue Jun 03 00:05:27 volumio volumio[14848]: info: CorePlayQueue::getQueue Jun 03 00:05:27 volumio volumio[14848]: info: Listing playlists Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 03 00:05:27 volumio volumio[14848]: info: Received Get System Info Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 00:05:27 volumio volumio[14848]: info: Discovery: Getting this device information Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:27 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 00:05:27 volumio volumio[14848]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:27 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:28 volumio volumio[14848]: info: Discovery: adding 1f9f14ad-7f50-4ca8-85c7-07fb266def0c Jun 03 00:05:28 volumio volumio[14848]: info: Discovery: Found device Volumio Jun 03 00:05:28 volumio volumio[14848]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:28 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:28 volumio volumio[14848]: info: Discovery: this is already registered, 1f9f14ad-7f50-4ca8-85c7-07fb266def0c Jun 03 00:05:28 volumio volumio[14848]: info: Discovery: Found device Volumio Jun 03 00:05:28 volumio volumio[14848]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:28 volumio volumio[14848]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:30 volumio volumio-remote-updater[998]: [2026-06-03 00:05:30] [connect] Successful connection Jun 03 00:05:30 volumio volumio-remote-updater[998]: [2026-06-03 00:05:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1780437930 101 Jun 03 00:05:30 volumio volumio[14848]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 4 Jun 03 00:05:32 volumio volumio[14848]: info: Preload queue cleared Jun 03 00:05:32 volumio volumio[14848]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 03 00:05:32 volumio volumio[14848]: info: CoreStateMachine::ClearQueue Jun 03 00:05:32 volumio volumio[14848]: info: CoreStateMachine::stop Jun 03 00:05:32 volumio volumio[14848]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:32 volumio volumio[14848]: info: CorePlayQueue::clearPlayQueue Jun 03 00:05:32 volumio volumio[14848]: info: CorePlayQueue::saveQueue Jun 03 00:05:32 volumio volumio[14848]: info: CoreCommandRouter::volumioPushQueue Jun 03 00:05:32 volumio volumio[14848]: info: CoreStateMachine::addQueueItems Jun 03 00:05:32 volumio volumio[14848]: info: CorePlayQueue::addQueueItems Jun 03 00:05:32 volumio volumio[14848]: info: Preload queue cleared Jun 03 00:05:32 volumio volumio[14848]: info: Adding Item to queue: music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 Jun 03 00:05:32 volumio volumio[14848]: info: Exploding uri music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 in service mpd Jun 03 00:05:32 volumio volumio[14848]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:32 volumio volumio[14848]: TypeError: Cannot read properties of undefined (reading 'then') Jun 03 00:05:32 volumio volumio[14848]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2541:19) Jun 03 00:05:32 volumio volumio[14848]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2339:21) Jun 03 00:05:32 volumio volumio[14848]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Jun 03 00:05:32 volumio volumio[14848]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jun 03 00:05:32 volumio volumio[14848]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jun 03 00:05:32 volumio volumio[14848]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jun 03 00:05:32 volumio volumio[14848]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Jun 03 00:05:32 volumio volumio[14848]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:511:25) Jun 03 00:05:32 volumio volumio[14848]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Jun 03 00:05:32 volumio volumio[14848]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Jun 03 00:05:32 volumio volumio[14848]: at Socket.emit (node:events:514:28) Jun 03 00:05:32 volumio volumio[14848]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 03 00:05:32 volumio volumio[14848]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jun 03 00:05:32 volumio volumio[14848]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:32 volumio sudo[15014]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-03 00:04' Jun 03 00:05:32 volumio sudo[15014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:32 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 03 00:05:32 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jun 03 00:05:32 volumio sudo[14904]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:32 volumio sudo[15014]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:33 volumio volumio5-onboarding[1523]: time=2026-06-03T00:05:33.312+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Jun 03 00:05:33 volumio volumio-remote-updater[998]: [2026-06-03 00:05:33] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 03 00:05:33 volumio volumio-remote-updater[998]: [2026-06-03 00:05:33] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 03 00:05:33 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 03 00:05:33 volumio volumio5-onboarding[1523]: time=2026-06-03T00:05:33.313+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Jun 03 00:05:33 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 03 00:05:33 volumio systemd[1]: volumio.service: Consumed 4.587s CPU time. Jun 03 00:05:33 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Jun 03 00:05:33 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Jun 03 00:05:33 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jun 03 00:05:33 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Jun 03 00:05:33 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Jun 03 00:05:33 volumio systemd[1]: volumio.service: Consumed 4.587s CPU time. Jun 03 00:05:33 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Jun 03 00:05:33 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Jun 03 00:05:33 volumio volumio[15040]: info: ------------------------------------------- Jun 03 00:05:33 volumio volumio[15040]: info: ----- Volumio3 ---- Jun 03 00:05:33 volumio volumio[15040]: info: ------------------------------------------- Jun 03 00:05:33 volumio volumio[15040]: info: ----- System startup ---- Jun 03 00:05:33 volumio volumio[15040]: info: ------------------------------------------- Jun 03 00:05:34 volumio volumio[15040]: info: MYVOLUMIO Environment detected Jun 03 00:05:34 volumio volumio[15040]: info: Plugin folders cleanup Jun 03 00:05:34 volumio volumio[15040]: info: Scanning into folder /volumio/app/plugins/ Jun 03 00:05:34 volumio volumio[15040]: info: Scanning category audio_interface Jun 03 00:05:34 volumio volumio[15040]: info: Scanning category miscellanea Jun 03 00:05:34 volumio volumio[15040]: info: Scanning category music_service Jun 03 00:05:34 volumio volumio[15040]: info: Scanning category plugins.json Jun 03 00:05:34 volumio volumio[15040]: info: Scanning category system_controller Jun 03 00:05:34 volumio volumio[15040]: info: Scanning category user_interface Jun 03 00:05:34 volumio volumio[15040]: info: Scanning into folder /data/plugins/ Jun 03 00:05:34 volumio volumio[15040]: info: Scanning category system_controller Jun 03 00:05:34 volumio volumio[15040]: info: Plugin folders cleanup completed Jun 03 00:05:34 volumio volumio[15040]: info: ------------------------------------------- Jun 03 00:05:34 volumio volumio[15040]: info: ----- Core plugins startup ---- Jun 03 00:05:34 volumio volumio[15040]: info: ------------------------------------------- Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugins from folder /volumio/app/plugins/ Jun 03 00:05:34 volumio volumio[15040]: info: Adding plugin upnp to MyMusic Plugins Jun 03 00:05:34 volumio volumio[15040]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 03 00:05:34 volumio volumio[15040]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugins from folder /data/plugins/ Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "system"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "appearance"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "network"... Jun 03 00:05:34 volumio volumio[15040]: info: Refreshing Cached IP Addresses Jun 03 00:05:34 volumio sudo[15068]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 00:05:34 volumio sudo[15068]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:34 volumio sudo[15070]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 00:05:34 volumio sudo[15068]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:34 volumio sudo[15070]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:34 volumio sudo[15070]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "services"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "volumio5onboarding"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "alsa_controller"... Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "wizard"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "networkfs"... Jun 03 00:05:34 volumio volumio[15040]: info: Starting Udev Watcher for removable devices Jun 03 00:05:34 volumio sudo[15096]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nmt,password=1234,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,ro,dir_mode=0777,file_mode=0777,vers=1.0 //192.168.1.6/share /mnt/NAS/PopCorn Jun 03 00:05:34 volumio sudo[15096]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:34 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 03 00:05:34 volumio kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 03 00:05:34 volumio kernel: CIFS: Attempting to mount //192.168.1.6/share Jun 03 00:05:34 volumio volumio[15040]: info: Mounting Device EFI Jun 03 00:05:34 volumio sudo[15106]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 00:05:34 volumio sudo[15106]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:34 volumio sudo[15106]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:34 volumio volumio[15040]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Jun 03 00:05:34 volumio volumio[15040]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:34 volumio volumio[15040]: error: Failed to mount EFI: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/EFI" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 00:05:34 volumio volumio[15040]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Jun 03 00:05:34 volumio volumio[15040]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:34 volumio volumio[15040]: info: Mounting Device Musica Jun 03 00:05:34 volumio sudo[15114]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Musica -o noatime Jun 03 00:05:34 volumio sudo[15114]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:34 volumio sudo[15114]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:34 volumio volumio[15040]: mount: /media/Musica: /dev/sda2 already mounted on /media/Musica. Jun 03 00:05:34 volumio volumio[15040]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:34 volumio volumio[15040]: error: Failed to mount Musica: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/Musica" -o noatime Jun 03 00:05:34 volumio volumio[15040]: mount: /media/Musica: /dev/sda2 already mounted on /media/Musica. Jun 03 00:05:34 volumio volumio[15040]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:34 volumio volumio[15040]: info: Ignoring mount for partition: boot Jun 03 00:05:34 volumio volumio[15040]: info: Ignoring mount for partition: volumio Jun 03 00:05:34 volumio volumio[15040]: info: Ignoring mount for partition: volumio_data Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "volumio_command_line_client"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "upnp"... Jun 03 00:05:34 volumio volumio[15040]: info: [1780437934391] Starting Upmpd Daemon Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "my_music"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "mpd"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "upnp_browser"... Jun 03 00:05:34 volumio volumio[15040]: info: Starting UPNP Browser Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "alarm-clock"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "airplay_emulation"... Jun 03 00:05:34 volumio volumio[15040]: info: Starting Shairport Sync Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "last_100"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "webradio"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "i2s_dacs"... Jun 03 00:05:34 volumio volumio[15040]: info: I2S DAC not set, start Auto-detection Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "volumiodiscovery"... Jun 03 00:05:34 volumio volumio[15040]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:34 volumio volumio[15040]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:34 volumio volumio[15040]: *** WARNING *** For more information see Jun 03 00:05:34 volumio volumio[15040]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:34 volumio volumio[15040]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:34 volumio volumio[15040]: *** WARNING *** For more information see Jun 03 00:05:34 volumio node[15040]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:34 volumio node[15040]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:34 volumio node[15040]: *** WARNING *** For more information see Jun 03 00:05:34 volumio node[15040]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:34 volumio node[15040]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:34 volumio node[15040]: *** WARNING *** For more information see Jun 03 00:05:34 volumio volumio[15040]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 03 00:05:34 volumio volumio[15040]: info: Discovery: Started advertising with name: Volumio Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "outputs"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "albumart"... Jun 03 00:05:34 volumio volumio[15040]: info: Plugin example_plugin is not enabled Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "inputs"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "updater_comm"... Jun 03 00:05:34 volumio volumio[15040]: info: Plugin mpdemulation is not enabled Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "rest_api"... Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "websocket"... Jun 03 00:05:34 volumio volumio[15040]: info: Starting Socket.io Server version 1.7.4 Jun 03 00:05:34 volumio volumio[15040]: info: Loading plugin "rpi_eeprom_config"... Jun 03 00:05:34 volumio volumio[15040]: info: Applying required configuration parameters for plugin rpi_eeprom_config Jun 03 00:05:34 volumio volumio[15040]: info: [RpiEepromConfig] Hardware capabilities loaded Jun 03 00:05:34 volumio volumio[15040]: info: Loading i18n strings for locale es Jun 03 00:05:34 volumio volumio[15040]: Updating browse sources language Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::initPlayerControls Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 00:05:34 volumio volumio[15040]: Express server listening on port 3000 Jun 03 00:05:34 volumio volumio[15040]: [Metrics] WebUI: 1s 67.42ms Jun 03 00:05:34 volumio volumio[15040]: info: CoreStateMachine::resetVolumioState Jun 03 00:05:34 volumio volumio[15040]: info: CoreStateMachine::getcurrentVolume Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::volumioRetrievevolume Jun 03 00:05:34 volumio volumio[15040]: info: CoreStateMachine::pushState Jun 03 00:05:34 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:34 volumio volumio[15118]: Forking 3 albumart workers Jun 03 00:05:34 volumio volumio[15040]: info: Volumio Network Manager: Network status updated: 1 Jun 03 00:05:34 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Jun 03 00:05:34 volumio volumio[15040]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.63 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 1 Jun 03 00:05:34 volumio volumio[15040]: info: Cannot read play queue from file Jun 03 00:05:34 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:34 volumio volumio[15040]: info: CoreStateMachine::setRepeat false single undefined Jun 03 00:05:34 volumio volumio[15040]: info: CoreStateMachine::pushState Jun 03 00:05:34 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:34 volumio volumio[15040]: info: CoreStateMachine::setRandom null Jun 03 00:05:34 volumio volumio[15040]: info: CoreStateMachine::pushState Jun 03 00:05:34 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:34 volumio volumio[15040]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:34 volumio volumio[15040]: info: Setting Device type: Raspberry PI Jun 03 00:05:34 volumio volumio[15040]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 03 00:05:34 volumio volumio[15040]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Jun 03 00:05:34 volumio volumio[15040]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 03 00:05:34 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::volumioGetVisibleSources Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:35 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::volumioGetQueue Jun 03 00:05:35 volumio volumio[15040]: info: CoreStateMachine::getQueue Jun 03 00:05:35 volumio volumio[15040]: info: CorePlayQueue::getQueue Jun 03 00:05:35 volumio volumio[15040]: info: Listing playlists Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 03 00:05:35 volumio volumio[15040]: info: Received Get System Info Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 00:05:35 volumio volumio[15040]: info: Discovery: Getting this device information Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:35 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:35 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15134]: Starting albumart workers Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15133]: Starting albumart workers Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15135]: Starting albumart workers Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:35 volumio volumio[15040]: info: Discovery: adding 1f9f14ad-7f50-4ca8-85c7-07fb266def0c Jun 03 00:05:35 volumio volumio[15040]: info: Discovery: Found device Volumio Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:35 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:35 volumio volumio[15040]: info: Discovery: this is already registered, 1f9f14ad-7f50-4ca8-85c7-07fb266def0c Jun 03 00:05:35 volumio volumio[15040]: info: Discovery: Found device Volumio Jun 03 00:05:35 volumio volumio[15040]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:35 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:38 volumio volumio-remote-updater[998]: [2026-06-03 00:05:38] [connect] Successful connection Jun 03 00:05:38 volumio volumio-remote-updater[998]: [2026-06-03 00:05:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1780437938 101 Jun 03 00:05:38 volumio volumio[15040]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 3 Jun 03 00:05:40 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Jun 03 00:05:40 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Jun 03 00:05:40 volumio sudo[15096]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:40 volumio volumio[15040]: info: Cannot mount NAS PopCorn at system boot, trial number 1 ,retrying in 5 seconds Jun 03 00:05:40 volumio volumio[15040]: info: Completed loading Core Plugins Jun 03 00:05:40 volumio volumio[15040]: info: Preparing to generate the ALSA configuration file Jun 03 00:05:40 volumio volumio[15040]: info: Asound.conf file unchanged, so no further update is needed Jun 03 00:05:40 volumio volumio[15040]: info: Output device has changed, restarting MPD Jun 03 00:05:40 volumio volumio[15040]: info: Output device has changed, restarting Shairport Sync Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:40 volumio sudo[15193]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 03 00:05:40 volumio sudo[15193]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio sudo[15195]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 03 00:05:40 volumio sudo[15195]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio sudo[15193]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:40 volumio volumio[15040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 00:05:40 volumio volumio[15040]: info: ___________ START PLUGINS ___________ Jun 03 00:05:40 volumio volumio[15040]: info: ControllerMpd::onStart: Initializing MPD Jun 03 00:05:40 volumio volumio[15040]: info: Creating MPD Configuration file Jun 03 00:05:40 volumio systemd[1]: Stopping mpd.service - Music Player Daemon... Jun 03 00:05:40 volumio sudo[15203]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Jun 03 00:05:40 volumio sudo[15203]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio sudo[15205]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 03 00:05:40 volumio sudo[15205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio sudo[15205]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 03 00:05:40 volumio volumio[15040]: info: [1780437940553] CoreMusicLibrary::Adding element Media Servers Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:40 volumio sudo[15203]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:40 volumio volumio[15040]: info: UPNP Browser: Client initialized successfully Jun 03 00:05:40 volumio sudo[15209]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 03 00:05:40 volumio sudo[15209]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 03 00:05:40 volumio volumio[15040]: info: [1780437940574] CoreMusicLibrary::Adding element Last_100 Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 03 00:05:40 volumio volumio[15040]: info: [1780437940575] CoreMusicLibrary::Adding element Webradio Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 00:05:40 volumio volumio[15040]: info: Initializing BBC Radios Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Starting Raspberry Pi EEPROM Configuration Manager Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Detected full model string: Raspberry Pi 5 Model B Rev 1.0 Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Matched to capability profile: Raspberry Pi 5 Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Detected model: Raspberry Pi 5 Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Boot modes: sd, usb, nvme Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Using rpi-eeprom-config at: /usr/bin/rpi-eeprom-config Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Backup directory ensured: /data/configuration/system_controller/rpi_eeprom_config/backup Jun 03 00:05:40 volumio volumio[15040]: info: [RpiEepromConfig] Plugin started successfully Jun 03 00:05:40 volumio volumio[15040]: info: Volumio Calling Home Jun 03 00:05:40 volumio volumio[15040]: info: MPD Permissions set Jun 03 00:05:40 volumio volumio[15040]: info: MPD Permissions set Jun 03 00:05:40 volumio volumio[15040]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:40 volumio volumio[15040]: info: Starting Shairport Sync Jun 03 00:05:40 volumio volumio[15040]: info: Starting Shairport Sync Jun 03 00:05:40 volumio volumio[15040]: info: Starting Shairport Sync Jun 03 00:05:40 volumio sudo[15250]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 00:05:40 volumio sudo[15250]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio sudo[15251]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 00:05:40 volumio sudo[15251]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio sudo[15253]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 03 00:05:40 volumio sudo[15253]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:40 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver... Jun 03 00:05:40 volumio systemd[1]: shairport-sync.service: Deactivated successfully. Jun 03 00:05:40 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 03 00:05:40 volumio systemd[1]: shairport-sync.service: Consumed 19.403s CPU time. Jun 03 00:05:40 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver. Jun 03 00:05:40 volumio sudo[15250]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:40 volumio sudo[15251]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:40 volumio systemd[1]: mpd.service: Deactivated successfully. Jun 03 00:05:40 volumio systemd[1]: Stopped mpd.service - Music Player Daemon. Jun 03 00:05:40 volumio systemd[1]: mpd.service: Consumed 1min 12.240s CPU time. Jun 03 00:05:40 volumio volumio[15040]: info: Shairport-Sync Started Jun 03 00:05:40 volumio volumio[15040]: Error adding Membership: Error: addMembership EINVAL Jun 03 00:05:40 volumio volumio[15040]: info: Volumio called home Jun 03 00:05:40 volumio sudo[15253]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:40 volumio volumio[15040]: info: Shairport-Sync Started Jun 03 00:05:40 volumio systemd[1]: mpd.socket: Deactivated successfully. Jun 03 00:05:40 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Jun 03 00:05:40 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Jun 03 00:05:40 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Jun 03 00:05:40 volumio volumio[15040]: info: Shairport-Sync Started Jun 03 00:05:40 volumio systemd[1]: Starting mpd.service - Music Player Daemon... Jun 03 00:05:40 volumio volumio[15040]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:40 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:40 volumio sudo[15259]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 03 00:05:40 volumio sudo[15259]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 03 00:05:40 volumio sudo[15259]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:41 volumio mpd[15275]: 2026-06-03T00:05:41 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 03 00:05:41 volumio systemd[1]: Started mpd.service - Music Player Daemon. Jun 03 00:05:41 volumio sudo[15195]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:41 volumio sudo[15209]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:41 volumio volumio[15040]: error: updateQueue error: null Jun 03 00:05:41 volumio volumio[15040]: info: Completed starting Core Plugins Jun 03 00:05:41 volumio volumio[15040]: info: ------------------------------------------- Jun 03 00:05:41 volumio volumio[15040]: info: ----- MyVolumio plugins startup ---- Jun 03 00:05:41 volumio volumio[15040]: info: ------------------------------------------- Jun 03 00:05:41 volumio volumio[15040]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 03 00:05:41 volumio volumio[15040]: error: updateQueue error: null Jun 03 00:05:41 volumio volumio[15040]: info: MPD running with PID15275 Jun 03 00:05:41 volumio volumio[15040]: ,establishing connection Jun 03 00:05:41 volumio volumio[15040]: error: updateQueue error: null Jun 03 00:05:41 volumio volumio[15040]: info: Preload queue cleared Jun 03 00:05:41 volumio volumio[15040]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::ClearQueue Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::stop Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:41 volumio volumio[15040]: info: CorePlayQueue::clearPlayQueue Jun 03 00:05:41 volumio volumio[15040]: info: CorePlayQueue::saveQueue Jun 03 00:05:41 volumio volumio[15040]: info: CoreCommandRouter::volumioPushQueue Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::addQueueItems Jun 03 00:05:41 volumio volumio[15040]: info: CorePlayQueue::addQueueItems Jun 03 00:05:41 volumio volumio[15040]: info: Preload queue cleared Jun 03 00:05:41 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 Jun 03 00:05:41 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 in service mpd Jun 03 00:05:41 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Brunette%20Models/Autarky%20-%20Single%20%5B24%2F96%20Studio%20Master%20Technology%5D/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FBRUNETTE_MODELS__Autarky.mp3&metadata=false Jun 03 00:05:41 volumio volumio[15040]: info: URI /mnt/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 Jun 03 00:05:41 volumio volumio[15040]: info: CoreCommandRouter::volumioPushQueue Jun 03 00:05:41 volumio volumio[15040]: info: CorePlayQueue::saveQueue Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::updateTrackBlock Jun 03 00:05:41 volumio volumio[15040]: info: CorePlayQueue::getTrackBlock Jun 03 00:05:41 volumio volumio[15040]: info: CoreCommandRouter::volumioPlay Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::play index 0 Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:41 volumio volumio[15040]: info: CoreStateMachine::addQueueItems Jun 03 00:05:41 volumio volumio[15040]: info: CorePlayQueue::addQueueItems Jun 03 00:05:41 volumio volumio[15040]: info: Preload queue cleared Jun 03 00:05:41 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/MendelssohnVC24.flac Jun 03 00:05:41 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/MendelssohnVC24.flac in service mpd Jun 03 00:05:41 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Flac Jun 03 00:05:41 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Flac in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/M.Vanessa.Paradis.Un.Monstre.A.Paris.(A.Monster.In.Paris).Soundtrack.2011 Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/M.Vanessa.Paradis.Un.Monstre.A.Paris.(A.Monster.In.Paris).Soundtrack.2011 in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Mélanie Laurent - En T'attendant (Feat. Damien Rice)(2011)(FLAC) Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Mélanie Laurent - En T'attendant (Feat. Damien Rice)(2011)(FLAC) in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/mp3_wma_ogg Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/mp3_wma_ogg in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/NuevaMusicaEscucharFiltroEntrada Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/NuevaMusicaEscucharFiltroEntrada in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/The National - The Virginia EP [2008] Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/The National - The Virginia EP [2008] in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis - Divinidylle Tour (2008) - Chanson [www.torrentazos.com] Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis - Divinidylle Tour (2008) - Chanson [www.torrentazos.com] in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis - Love Songs 2013 Pop 2CD Limited Edition 320kbps CBR MP3 [VX] Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis - Love Songs 2013 Pop 2CD Limited Edition 320kbps CBR MP3 [VX] in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis - M & J (1988) [FLAC (img+cue)] Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis - M & J (1988) [FLAC (img+cue)] in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis -- Divinidylle Tour Live [FLAC] Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis -- Divinidylle Tour Live [FLAC] in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis Best of 2009 Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis Best of 2009 in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: Adding Item to queue: music-library/USB/Musica/Vanessa Paradis_-_Love Songs (Limited Edition) (2013)[Mp3][www.lokotorrents.com] Jun 03 00:05:42 volumio volumio[15040]: info: Exploding uri music-library/USB/Musica/Vanessa Paradis_-_Love Songs (Limited Edition) (2013)[Mp3][www.lokotorrents.com] in service mpd Jun 03 00:05:42 volumio volumio[15040]: info: CoreStateMachine::stop Jun 03 00:05:42 volumio volumio[15040]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:42 volumio volumio[15040]: info: CoreStateMachine::play index undefined Jun 03 00:05:42 volumio volumio[15040]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:42 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:42 volumio volumio[15040]: info: CoreStateMachine::startPlaybackTimer Jun 03 00:05:42 volumio volumio[15040]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:42 volumio volumio[15040]: verbose: ControllerMpd::clearAddPlayTracks USB/Musica/BRUNETTE_MODELS__Autarky.mp3 Jun 03 00:05:42 volumio volumio[15040]: verbose: ControllerMpd::sendMpdCommand stop Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Heifetz%2C%20NYPO%2C%20Cantelli/Mendelssohn%20-%20Violin%20Concerto%20in%20E%20minor%2C%20Op.%2064/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FMendelssohnVC24.flac&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/MendelssohnVC24.flac Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA1%20-%20Rolling%20In%20The%20Deep.flac&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A1 - Rolling In The Deep.flac Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA2%20-%20Rumour%20Has%20It.flac&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A2 - Rumour Has It.flac Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA3%20-%20Turning%20Tables.flac&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A3 - Turning Tables.flac Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA4%20-%20Don't%20You%20Remember.flac&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A4 - Don't You Remember.flac Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA5%20-%20Set%20Fire%20To%20The%20Rain.flac&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A5 - Set Fire To The Rain.flac Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FA6%20-%20He%20Won't%20Go.flac&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/A6 - He Won't Go.flac Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FAdele%20-%2021.cue&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/Adele - 21.cue Jun 03 00:05:42 volumio volumio[15040]: info: ALBUMART /albumart?cacheid=701&web=Adele/21/extralarge&path=%2Fmnt%2FUSB%2FMusica%2FFlac%2FAdele%20-%2021%20(2011)%20%5Bflac%5D%20%7BXL%20Recordings%20LP%3B%20DMR%7D%2FAdele%20-%2021.cue&metadata=false Jun 03 00:05:42 volumio volumio[15040]: info: URI /mnt/USB/Musica/Flac/Adele - 21 (2011) [flac] {XL Recordings LP; DMR}/Adele - 21.cue Jun 03 00:05:42 volumio volumio[15040]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:42 volumio volumio[15040]: Error: Unable to resolve or reject the same promise twice Jun 03 00:05:42 volumio volumio[15040]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 03 00:05:42 volumio volumio[15040]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Jun 03 00:05:42 volumio volumio[15040]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jun 03 00:05:42 volumio volumio[15040]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jun 03 00:05:42 volumio volumio[15040]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jun 03 00:05:42 volumio volumio[15040]: at Socket.emit (node:events:514:28) Jun 03 00:05:42 volumio volumio[15040]: at addChunk (node:internal/streams/readable:343:12) Jun 03 00:05:42 volumio volumio[15040]: at readableAddChunk (node:internal/streams/readable:312:11) Jun 03 00:05:42 volumio volumio[15040]: at Readable.push (node:internal/streams/readable:253:10) Jun 03 00:05:42 volumio volumio[15040]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jun 03 00:05:42 volumio volumio[15040]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:42 volumio sudo[15295]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-03 00:04' Jun 03 00:05:42 volumio sudo[15295]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:42 volumio sudo[15295]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:43 volumio volumio-remote-updater[998]: [2026-06-03 00:05:43] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 03 00:05:43 volumio volumio-remote-updater[998]: [2026-06-03 00:05:43] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 03 00:05:43 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 03 00:05:43 volumio volumio5-onboarding[1523]: time=2026-06-03T00:05:43.016+02:00 level=ERROR msg="failed reading message" error="websocket: close 1006 (abnormal closure): unexpected EOF" Jun 03 00:05:43 volumio volumio5-onboarding[1523]: time=2026-06-03T00:05:43.016+02:00 level=WARN msg="reconnection attempt failed" error="dial tcp 127.0.0.1:3000: connect: connection refused" Jun 03 00:05:43 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 03 00:05:43 volumio systemd[1]: volumio.service: Consumed 5.772s CPU time. Jun 03 00:05:43 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Jun 03 00:05:43 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Jun 03 00:05:43 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 3. Jun 03 00:05:43 volumio systemd[1]: Started dynamicswap.service - dynamicswap service. Jun 03 00:05:43 volumio systemd[1]: Stopped volumio.service - Volumio Backend Module. Jun 03 00:05:43 volumio systemd[1]: volumio.service: Consumed 5.772s CPU time. Jun 03 00:05:43 volumio systemd[1]: Started volumio.service - Volumio Backend Module. Jun 03 00:05:43 volumio systemd[1]: dynamicswap.service: Deactivated successfully. Jun 03 00:05:43 volumio volumio[15317]: info: ------------------------------------------- Jun 03 00:05:43 volumio volumio[15317]: info: ----- Volumio3 ---- Jun 03 00:05:43 volumio volumio[15317]: info: ------------------------------------------- Jun 03 00:05:43 volumio volumio[15317]: info: ----- System startup ---- Jun 03 00:05:43 volumio volumio[15317]: info: ------------------------------------------- Jun 03 00:05:43 volumio volumio[15317]: info: MYVOLUMIO Environment detected Jun 03 00:05:43 volumio volumio[15317]: info: Plugin folders cleanup Jun 03 00:05:43 volumio volumio[15317]: info: Scanning into folder /volumio/app/plugins/ Jun 03 00:05:43 volumio volumio[15317]: info: Scanning category audio_interface Jun 03 00:05:43 volumio volumio[15317]: info: Scanning category miscellanea Jun 03 00:05:43 volumio volumio[15317]: info: Scanning category music_service Jun 03 00:05:43 volumio volumio[15317]: info: Scanning category plugins.json Jun 03 00:05:43 volumio volumio[15317]: info: Scanning category system_controller Jun 03 00:05:43 volumio volumio[15317]: info: Scanning category user_interface Jun 03 00:05:43 volumio volumio[15317]: info: Scanning into folder /data/plugins/ Jun 03 00:05:43 volumio volumio[15317]: info: Scanning category system_controller Jun 03 00:05:43 volumio volumio[15317]: info: Plugin folders cleanup completed Jun 03 00:05:43 volumio volumio[15317]: info: ------------------------------------------- Jun 03 00:05:43 volumio volumio[15317]: info: ----- Core plugins startup ---- Jun 03 00:05:43 volumio volumio[15317]: info: ------------------------------------------- Jun 03 00:05:43 volumio volumio[15317]: info: Loading plugins from folder /volumio/app/plugins/ Jun 03 00:05:43 volumio volumio[15317]: info: Adding plugin upnp to MyMusic Plugins Jun 03 00:05:43 volumio volumio[15317]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 03 00:05:43 volumio volumio[15317]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 03 00:05:43 volumio volumio[15317]: info: Loading plugins from folder /data/plugins/ Jun 03 00:05:43 volumio volumio[15317]: info: Loading plugin "system"... Jun 03 00:05:43 volumio volumio[15317]: info: Loading plugin "appearance"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "network"... Jun 03 00:05:44 volumio volumio[15317]: info: Refreshing Cached IP Addresses Jun 03 00:05:44 volumio sudo[15346]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 03 00:05:44 volumio sudo[15346]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:44 volumio sudo[15346]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:44 volumio sudo[15348]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 03 00:05:44 volumio sudo[15348]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "services"... Jun 03 00:05:44 volumio sudo[15348]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "volumio5onboarding"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "alsa_controller"... Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "wizard"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "networkfs"... Jun 03 00:05:44 volumio volumio[15317]: info: Starting Udev Watcher for removable devices Jun 03 00:05:44 volumio sudo[15374]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=nmt,password=1234,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,ro,dir_mode=0777,file_mode=0777,vers=1.0 //192.168.1.6/share /mnt/NAS/PopCorn Jun 03 00:05:44 volumio sudo[15374]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:44 volumio kernel: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 03 00:05:44 volumio kernel: CIFS: VFS: Use of the less secure dialect vers=1.0 is not recommended unless required for access to very old servers Jun 03 00:05:44 volumio kernel: CIFS: Attempting to mount //192.168.1.6/share Jun 03 00:05:44 volumio volumio[15317]: info: Mounting Device EFI Jun 03 00:05:44 volumio sudo[15384]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/EFI -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 00:05:44 volumio sudo[15384]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:44 volumio sudo[15384]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:44 volumio volumio[15317]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Jun 03 00:05:44 volumio volumio[15317]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:44 volumio volumio[15317]: error: Failed to mount EFI: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/EFI" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Jun 03 00:05:44 volumio volumio[15317]: mount: /media/EFI: /dev/sda1 already mounted on /media/EFI. Jun 03 00:05:44 volumio volumio[15317]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:44 volumio volumio[15317]: info: Mounting Device Musica Jun 03 00:05:44 volumio sudo[15392]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda2 /mnt/USB/Musica -o noatime Jun 03 00:05:44 volumio sudo[15392]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jun 03 00:05:44 volumio sudo[15392]: pam_unix(sudo:session): session closed for user root Jun 03 00:05:44 volumio volumio[15317]: mount: /media/Musica: /dev/sda2 already mounted on /media/Musica. Jun 03 00:05:44 volumio volumio[15317]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:44 volumio volumio[15317]: error: Failed to mount Musica: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda2" "/mnt/USB/Musica" -o noatime Jun 03 00:05:44 volumio volumio[15317]: mount: /media/Musica: /dev/sda2 already mounted on /media/Musica. Jun 03 00:05:44 volumio volumio[15317]: dmesg(1) may have more information after failed mount system call. Jun 03 00:05:44 volumio volumio[15317]: info: Ignoring mount for partition: boot Jun 03 00:05:44 volumio volumio[15317]: info: Ignoring mount for partition: volumio Jun 03 00:05:44 volumio volumio[15317]: info: Ignoring mount for partition: volumio_data Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "volumio_command_line_client"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "upnp"... Jun 03 00:05:44 volumio volumio[15317]: info: [1780437944144] Starting Upmpd Daemon Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "my_music"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "mpd"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "upnp_browser"... Jun 03 00:05:44 volumio volumio[15317]: info: Starting UPNP Browser Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "alarm-clock"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "airplay_emulation"... Jun 03 00:05:44 volumio volumio[15317]: info: Starting Shairport Sync Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "last_100"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "webradio"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "i2s_dacs"... Jun 03 00:05:44 volumio volumio[15317]: info: I2S DAC not set, start Auto-detection Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "volumiodiscovery"... Jun 03 00:05:44 volumio volumio[15317]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:44 volumio volumio[15317]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:44 volumio volumio[15317]: *** WARNING *** For more information see Jun 03 00:05:44 volumio volumio[15317]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:44 volumio volumio[15317]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:44 volumio volumio[15317]: *** WARNING *** For more information see Jun 03 00:05:44 volumio node[15317]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:44 volumio node[15317]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:44 volumio node[15317]: *** WARNING *** For more information see Jun 03 00:05:44 volumio node[15317]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 03 00:05:44 volumio node[15317]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 03 00:05:44 volumio node[15317]: *** WARNING *** For more information see Jun 03 00:05:44 volumio volumio[15317]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 03 00:05:44 volumio volumio[15317]: info: Discovery: Started advertising with name: Volumio Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "outputs"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "albumart"... Jun 03 00:05:44 volumio volumio[15317]: info: Plugin example_plugin is not enabled Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "inputs"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "updater_comm"... Jun 03 00:05:44 volumio volumio[15317]: info: Plugin mpdemulation is not enabled Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "rest_api"... Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "websocket"... Jun 03 00:05:44 volumio volumio[15317]: info: Starting Socket.io Server version 1.7.4 Jun 03 00:05:44 volumio volumio[15317]: info: Loading plugin "rpi_eeprom_config"... Jun 03 00:05:44 volumio volumio[15317]: info: Applying required configuration parameters for plugin rpi_eeprom_config Jun 03 00:05:44 volumio volumio[15317]: info: [RpiEepromConfig] Hardware capabilities loaded Jun 03 00:05:44 volumio volumio[15317]: info: Loading i18n strings for locale es Jun 03 00:05:44 volumio volumio[15317]: Updating browse sources language Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::initPlayerControls Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: Express server listening on port 3000 Jun 03 00:05:44 volumio volumio[15317]: [Metrics] WebUI: 1s 65.89ms Jun 03 00:05:44 volumio volumio[15396]: Forking 3 albumart workers Jun 03 00:05:44 volumio volumio[15317]: info: CoreStateMachine::resetVolumioState Jun 03 00:05:44 volumio volumio[15317]: info: CoreStateMachine::getcurrentVolume Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::volumioRetrievevolume Jun 03 00:05:44 volumio volumio[15317]: info: CoreStateMachine::pushState Jun 03 00:05:44 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 03 00:05:44 volumio volumio[15317]: info: Volumio Network Manager: Network status updated: 1 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 1 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.63 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 1 Jun 03 00:05:44 volumio volumio[15317]: info: Cannot read play queue from file Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: info: CoreStateMachine::setRepeat false single undefined Jun 03 00:05:44 volumio volumio[15317]: info: CoreStateMachine::pushState Jun 03 00:05:44 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:44 volumio volumio[15317]: info: CoreStateMachine::setRandom null Jun 03 00:05:44 volumio volumio[15317]: info: CoreStateMachine::pushState Jun 03 00:05:44 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:44 volumio volumio[15317]: info: CoreCommandRouter::volumioPushState Jun 03 00:05:44 volumio volumio[15317]: info: Setting Device type: Raspberry PI Jun 03 00:05:44 volumio volumio[15317]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 03 00:05:44 volumio volumio[15317]: info: USB Boot Capable - System SBC Revision found in cpuinfo: d04170 Jun 03 00:05:44 volumio volumio[15317]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15317]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 2 Jun 03 00:05:44 volumio volumio[15409]: Starting albumart workers Jun 03 00:05:44 volumio volumio[15413]: Starting albumart workers Jun 03 00:05:44 volumio volumio[15422]: Starting albumart workers Jun 03 00:05:45 volumio volumio[15317]: info: Discovery: adding 1f9f14ad-7f50-4ca8-85c7-07fb266def0c Jun 03 00:05:45 volumio volumio[15317]: info: Discovery: Found device Volumio Jun 03 00:05:45 volumio volumio[15317]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:45 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:45 volumio volumio[15317]: info: Discovery: this is already registered, 1f9f14ad-7f50-4ca8-85c7-07fb266def0c Jun 03 00:05:45 volumio volumio[15317]: info: Discovery: Found device Volumio Jun 03 00:05:45 volumio volumio[15317]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:45 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:47 volumio volumio[15317]: verbose: New Socket.io Connection to 192.168.1.42 from 192.168.1.63 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/26.5 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 3 Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::volumioGetVisibleSources Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:47 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::volumioGetQueue Jun 03 00:05:47 volumio volumio[15317]: info: CoreStateMachine::getQueue Jun 03 00:05:47 volumio volumio[15317]: info: CorePlayQueue::getQueue Jun 03 00:05:47 volumio volumio[15317]: info: Listing playlists Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 03 00:05:47 volumio volumio[15317]: info: Received Get System Info Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 03 00:05:47 volumio volumio[15317]: info: Discovery: Getting this device information Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:47 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 03 00:05:47 volumio volumio[15317]: info: CoreCommandRouter::volumioGetState Jun 03 00:05:47 volumio volumio[15317]: info: CorePlayQueue::getTrack 0 Jun 03 00:05:48 volumio volumio-remote-updater[998]: [2026-06-03 00:05:48] [connect] Successful connection Jun 03 00:05:48 volumio volumio-remote-updater[998]: [2026-06-03 00:05:48] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1780437948 101 Jun 03 00:05:48 volumio volumio[15317]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 4 Jun 03 00:05:49 volumio volumio[15317]: info: Preload queue cleared Jun 03 00:05:49 volumio volumio[15317]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 03 00:05:49 volumio volumio[15317]: info: CoreStateMachine::ClearQueue Jun 03 00:05:49 volumio volumio[15317]: info: CoreStateMachine::stop Jun 03 00:05:49 volumio volumio[15317]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 03 00:05:49 volumio volumio[15317]: info: CorePlayQueue::clearPlayQueue Jun 03 00:05:49 volumio volumio[15317]: info: CorePlayQueue::saveQueue Jun 03 00:05:49 volumio volumio[15317]: info: CoreCommandRouter::volumioPushQueue Jun 03 00:05:49 volumio volumio[15317]: info: CoreStateMachine::addQueueItems Jun 03 00:05:49 volumio volumio[15317]: info: CorePlayQueue::addQueueItems Jun 03 00:05:49 volumio volumio[15317]: info: Preload queue cleared Jun 03 00:05:49 volumio volumio[15317]: info: Adding Item to queue: music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 Jun 03 00:05:49 volumio volumio[15317]: info: Exploding uri music-library/USB/Musica/BRUNETTE_MODELS__Autarky.mp3 in service mpd Jun 03 00:05:49 volumio volumio[15317]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:49 volumio volumio[15317]: TypeError: Cannot read properties of undefined (reading 'then') Jun 03 00:05:49 volumio volumio[15317]: at ControllerMpd.scanFolder (/volumio/app/plugins/music_service/mpd/index.js:2541:19) Jun 03 00:05:49 volumio volumio[15317]: at ControllerMpd.explodeUri (/volumio/app/plugins/music_service/mpd/index.js:2339:21) Jun 03 00:05:49 volumio volumio[15317]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:16) Jun 03 00:05:49 volumio volumio[15317]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24) Jun 03 00:05:49 volumio volumio[15317]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19) Jun 03 00:05:49 volumio volumio[15317]: at CorePlayQueue.addQueueItems (/volumio/app/playqueue.js:223:30) Jun 03 00:05:49 volumio volumio[15317]: at CoreStateMachine.addQueueItems (/volumio/app/statemachine.js:251:25) Jun 03 00:05:49 volumio volumio[15317]: at CoreCommandRouter.replaceAndPlay (/volumio/app/index.js:511:25) Jun 03 00:05:49 volumio volumio[15317]: at CoreCommandRouter.playItemsList (/volumio/app/index.js:484:17) Jun 03 00:05:49 volumio volumio[15317]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:142:33) Jun 03 00:05:49 volumio volumio[15317]: at Socket.emit (node:events:514:28) Jun 03 00:05:49 volumio volumio[15317]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jun 03 00:05:49 volumio volumio[15317]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Jun 03 00:05:49 volumio volumio[15317]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 03 00:05:50 volumio sudo[15488]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-06-03 00:04' Jun 03 00:05:50 volumio sudo[15488]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"