-- Logs begin at Thu 2019-02-14 02:11:59 PST, end at Sat 2025-12-13 08:17:59 PST. -- Dec 13 08:17:40 parsnip volumio[998]: info: CoreCommandRouter::volumioGetQueue Dec 13 08:17:40 parsnip volumio[998]: info: CoreStateMachine::getQueue Dec 13 08:17:40 parsnip volumio[998]: info: CorePlayQueue::getQueue Dec 13 08:17:44 parsnip volumio[998]: Searching plugin music_service/mpd Dec 13 08:17:44 parsnip volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 13 08:17:44 parsnip volumio[998]: info: All search sources collected, pushing search results Dec 13 08:17:45 parsnip volumio[998]: Searching plugin music_service/mpd Dec 13 08:17:45 parsnip volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 13 08:17:45 parsnip volumio[998]: info: All search sources collected, pushing search results Dec 13 08:17:48 parsnip kernel: hwmon hwmon1: Undervoltage detected! Dec 13 08:17:48 parsnip volumio[998]: Searching plugin music_service/mpd Dec 13 08:17:48 parsnip volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 13 08:17:49 parsnip volumio[998]: info: All search sources collected, pushing search results Dec 13 08:17:51 parsnip volumio[998]: Searching plugin music_service/mpd Dec 13 08:17:51 parsnip volumio[998]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 13 08:17:52 parsnip volumio[998]: info: All search sources collected, pushing search results Dec 13 08:17:58 parsnip volumio[998]: info: Preload queue cleared Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioAddQueueItems Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::addQueueItems Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::addQueueItems Dec 13 08:17:58 parsnip volumio[998]: info: Preload queue cleared Dec 13 08:17:58 parsnip volumio[998]: info: Adding Item to queue: music-library/USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac Dec 13 08:17:58 parsnip volumio[998]: info: Exploding uri music-library/USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac in service mpd Dec 13 08:17:58 parsnip volumio[998]: info: ALBUMART /albumart?cacheid=913&web=Franz%20Schubert%3B%20Alfred%20Brendel/Piano%20Works%201822-1828/extralarge&path=%2Fmnt%2FUSB%2Fhdd%2Faudio%2FS%2FSchubert%2C%20Franz%2FAlfred%20Brendel%20-%20Schubert%20Piano%20Works%201822-1828%2F3-05%20Moments%20musicaux%2C%20op.%2094%2C%20D.%20780%2C%20no.%201%20in%20C%20major%EF%BC%9A%20Moderato.flac&metadata=false Dec 13 08:17:58 parsnip volumio[998]: info: URI /mnt/USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushQueue Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::saveQueue Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::updateTrackBlock Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrackBlock Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPlay Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::play index 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::stop Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::play index undefined Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::startPlaybackTimer Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::clearAddPlayTracks USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand stop Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand stop took 1 milliseconds Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand clear Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand clear took 5 milliseconds Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand add "USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac" Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: error: updateQueue error: null Dec 13 08:17:58 parsnip kernel: hwmon hwmon1: Voltage normalised Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 10ms Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand add "USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac" took 8 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 7ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 6ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 6ms Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand play Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces system playlist update Dec 13 08:17:58 parsnip volumio[998]: info: Ignoring MPD Status Update Dec 13 08:17:58 parsnip volumio[998]: error: Upnp client error: Error: This socket has been ended by the other party Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 8ms Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand play took 5 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 5ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 5ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 4ms Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 13 08:17:58 parsnip volumio[998]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 13 08:17:58 parsnip volumio[998]: error: FusionDsp - File size not found in array! Dec 13 08:17:58 parsnip volumio[998]: info: FusionDsp - Effects disabled Dec 13 08:17:58 parsnip volumio[998]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Dec 13 08:17:58 parsnip volumio[998]: info: FusionDsp - ---- read samplerate from file: 44100 Dec 13 08:17:58 parsnip volumio[998]: error: FusionDsp - File size not found in array! Dec 13 08:17:58 parsnip volumio[998]: info: FusionDsp - Effects disabled Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 31 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 31 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 30 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 30 milliseconds Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: Dec 13 08:17:58 parsnip volumio[998]: ---------------------------- MPD announces state update: player Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::getState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand status Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 18 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 17 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 7 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 5 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand status took 5 milliseconds Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseState Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"378 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus stop Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"400 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus play Dec 13 08:17:58 parsnip volumio[998]: info: Received an update from plugin. extracting info from payload Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"400 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus play Dec 13 08:17:58 parsnip volumio[998]: info: Received an update from plugin. extracting info from payload Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"400 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus play Dec 13 08:17:58 parsnip volumio[998]: info: Received an update from plugin. extracting info from payload Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 87ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 148ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 148ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 148ms Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 107 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 104 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 105 milliseconds Dec 13 08:17:58 parsnip volumio[998]: info: sendMpdCommand playlistinfo took 105 milliseconds Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: verbose: ControllerMpd::parseTrackInfo Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1601,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"332 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus play Dec 13 08:17:58 parsnip volumio[998]: info: Received an update from plugin. extracting info from payload Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1830,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"330 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus play Dec 13 08:17:58 parsnip volumio[998]: info: Received an update from plugin. extracting info from payload Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1830,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"330 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus play Dec 13 08:17:58 parsnip volumio[998]: info: Received an update from plugin. extracting info from payload Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: ControllerMpd::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::servicePushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1830,"duration":338,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"330 Kbps","isStreaming":false,"title":"Moments musicaux, op. 94, D. 780, no. 1 in C major: Moderato","artist":"Franz Schubert; Alfred Brendel","album":"Piano Works 1822-1828","uri":"USB/hdd/audio/S/Schubert, Franz/Alfred Brendel - Schubert Piano Works 1822-1828/3-05 Moments musicaux, op. 94, D. 780, no. 1 in C major： Moderato.flac","trackType":"flac"} Dec 13 08:17:58 parsnip volumio[998]: verbose: CURRENT POSITION 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState stateService play Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::syncState currentStatus play Dec 13 08:17:58 parsnip volumio[998]: info: Received an update from plugin. extracting info from payload Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: CoreStateMachine::pushState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioPushState Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 249ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 236ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 237ms Dec 13 08:17:58 parsnip volumio[998]: info: ------------------------------ 237ms Dec 13 08:17:58 parsnip volumio[998]: info: CoreCommandRouter::volumioGetState Dec 13 08:17:58 parsnip volumio[998]: info: CorePlayQueue::getTrack 0 Dec 13 08:17:58 parsnip volumio[998]: info: [ASDebug] CurState: play PrevState: stop Dec 13 08:17:58 parsnip volumio[998]: info: [ASDebug] Togle GPIO: ON Dec 13 08:17:58 parsnip volumio[998]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 08:17:58 parsnip volumio[998]: Error: EBADF: bad file descriptor, write Dec 13 08:17:58 parsnip volumio[998]: at Object.writeSync (fs.js:711:3) Dec 13 08:17:58 parsnip volumio[998]: at Gpio.writeSync (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:243:8) Dec 13 08:17:58 parsnip volumio[998]: at AmpSwitchController.on (/data/plugins/system_controller/ampswitch/index.js:207:23) Dec 13 08:17:58 parsnip volumio[998]: at AmpSwitchController.parseStatus (/data/plugins/system_controller/ampswitch/index.js:190:86) Dec 13 08:17:58 parsnip volumio[998]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Dec 13 08:17:58 parsnip volumio[998]: at Socket.onevent (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:278:10) Dec 13 08:17:58 parsnip volumio[998]: at Socket.onpacket (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/socket.js:236:12) Dec 13 08:17:58 parsnip volumio[998]: at Manager. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Dec 13 08:17:58 parsnip volumio[998]: at Manager.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Dec 13 08:17:58 parsnip volumio[998]: at Manager.ondecoded (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:349:8) Dec 13 08:17:58 parsnip volumio[998]: at Decoder. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Dec 13 08:17:58 parsnip volumio[998]: at Decoder.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) Dec 13 08:17:58 parsnip volumio[998]: at Decoder.add (/data/plugins/system_controller/ampswitch/node_modules/socket.io-parser/index.js:254:12) Dec 13 08:17:58 parsnip volumio[998]: at Manager.ondata (/data/plugins/system_controller/ampswitch/node_modules/socket.io-client/lib/manager.js:339:16) Dec 13 08:17:58 parsnip volumio[998]: at Socket. (/data/plugins/system_controller/ampswitch/node_modules/component-bind/index.js:21:15) Dec 13 08:17:58 parsnip volumio[998]: at Socket.Emitter.emit (/data/plugins/system_controller/ampswitch/node_modules/component-emitter/index.js:145:20) { Dec 13 08:17:58 parsnip volumio[998]: errno: -9, Dec 13 08:17:58 parsnip volumio[998]: syscall: 'write', Dec 13 08:17:58 parsnip volumio[998]: code: 'EBADF' Dec 13 08:17:58 parsnip volumio[998]: } Dec 13 08:17:58 parsnip volumio[998]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 13 08:17:59 parsnip sudo[1851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-13 08:16 Dec 13 08:17:59 parsnip sudo[1851]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"