Feb 11 17:09:00 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:01 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:03 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:04 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:05 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:06 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:07 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:09 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:10 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:11 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:13 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:14 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:15 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:16 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:18 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:19 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:20 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:21 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:22 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:23 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:24 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:26 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:27 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:28 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:29 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:30 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:31 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:32 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:34 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:35 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:36 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:37 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:38 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:40 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:41 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:42 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:44 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:45 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:46 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:47 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:09:47 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:47 volumiotest volumio[1385]: info: Prefetching next song Feb 11 17:09:47 volumiotest volumio[1385]: info: DOING PREFETCH IN MPD Feb 11 17:09:47 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/Alicia Keys - HERE (Deluxe 2016) [24-44 HD FLAC]/02. The Gospel.flac" Feb 11 17:09:47 volumiotest volumio[1385]: info: Feb 11 17:09:47 volumiotest volumio[1385]: ---------------------------- MPD announces system playlist update Feb 11 17:09:47 volumiotest volumio[1385]: info: Ignoring MPD Status Update Feb 11 17:09:47 volumiotest volumio[1385]: info: sendMpdCommand add "NAS/Music/Alicia Keys - HERE (Deluxe 2016) [24-44 HD FLAC]/02. The Gospel.flac" took 2 milliseconds Feb 11 17:09:47 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 11 17:09:47 volumiotest volumio[1385]: info: Feb 11 17:09:47 volumiotest volumio[1385]: ---------------------------- MPD announces state update: options Feb 11 17:09:47 volumiotest volumio[1385]: info: ------------------------------ 4ms Feb 11 17:09:47 volumiotest volumio[1385]: info: sendMpdCommand consume 1 took 3 milliseconds Feb 11 17:09:47 volumiotest volumio[1385]: info: ControllerMpd::getState Feb 11 17:09:47 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand status Feb 11 17:09:47 volumiotest volumio[1385]: info: sendMpdCommand status took 2 milliseconds Feb 11 17:09:47 volumiotest volumio[1385]: verbose: ControllerMpd::parseState Feb 11 17:09:47 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 17:09:47 volumiotest volumio[1385]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 11 17:09:47 volumiotest volumio[1385]: verbose: ControllerMpd::parseTrackInfo Feb 11 17:09:47 volumiotest volumio[1385]: info: ControllerMpd::pushState Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreCommandRouter::servicePushState Feb 11 17:09:47 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:09:47 volumiotest volumio[1385]: verbose: STATE SERVICE {"status":"play","position":0,"seek":59099,"duration":64,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1589 Kbps","isStreaming":false,"title":"The Beginning (Interlude)","artist":"Alicia Keys","album":"HERE","uri":"NAS/Music/Alicia Keys - HERE (Deluxe 2016) [24-44 HD FLAC]/01. The Beginning (Interlude).flac","trackType":"flac"} Feb 11 17:09:47 volumiotest volumio[1385]: verbose: CURRENT POSITION 0 Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreStateMachine::syncState stateService play Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreStateMachine::syncState currentStatus play Feb 11 17:09:47 volumiotest volumio[1385]: info: Received an update from plugin. extracting info from payload Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:09:47 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:09:47 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:09:47 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:09:47 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:09:47 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:09:47 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:09:47 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:09:47 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:09:47 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:09:47 volumiotest volumio[1385]: info: ------------------------------ 115ms Feb 11 17:09:47 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:48 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:49 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:51 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:51 volumiotest volumio[1385]: info: CoreStateMachine::startPlaybackTimer Feb 11 17:09:51 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: Feb 11 17:09:52 volumiotest volumio[1385]: ---------------------------- MPD announces system playlist update Feb 11 17:09:52 volumiotest volumio[1385]: info: Ignoring MPD Status Update Feb 11 17:09:52 volumiotest volumio[1385]: info: Feb 11 17:09:52 volumiotest volumio[1385]: ---------------------------- MPD announces state update: player Feb 11 17:09:52 volumiotest volumio[1385]: info: ControllerMpd::getState Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand status Feb 11 17:09:52 volumiotest volumio[1385]: info: Feb 11 17:09:52 volumiotest volumio[1385]: ---------------------------- MPD announces state update: player Feb 11 17:09:52 volumiotest volumio[1385]: info: ControllerMpd::getState Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand status Feb 11 17:09:52 volumiotest volumio[1385]: info: ------------------------------ 10ms Feb 11 17:09:52 volumiotest volumio[1385]: info: sendMpdCommand status took 9 milliseconds Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::parseState Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 17:09:52 volumiotest volumio[1385]: info: sendMpdCommand status took 7 milliseconds Feb 11 17:09:52 volumiotest volumio[1385]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::parseState Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::parseTrackInfo Feb 11 17:09:52 volumiotest volumio[1385]: info: ControllerMpd::pushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::servicePushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1221 Kbps","isStreaming":false,"title":"The Gospel","artist":"Alicia Keys","album":"HERE","uri":"NAS/Music/Alicia Keys - HERE (Deluxe 2016) [24-44 HD FLAC]/02. The Gospel.flac","trackType":"flac"} Feb 11 17:09:52 volumiotest volumio[1385]: verbose: CURRENT POSITION 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::syncState stateService play Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::syncState currentStatus play Feb 11 17:09:52 volumiotest volumio[1385]: info: Received an update from plugin. extracting info from payload Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: ------------------------------ 104ms Feb 11 17:09:52 volumiotest volumio[1385]: info: sendMpdCommand playlistinfo took 90 milliseconds Feb 11 17:09:52 volumiotest volumio[1385]: verbose: ControllerMpd::parseTrackInfo Feb 11 17:09:52 volumiotest volumio[1385]: info: ControllerMpd::pushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::servicePushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":182,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1221 Kbps","isStreaming":false,"title":"The Gospel","artist":"Alicia Keys","album":"HERE","uri":"NAS/Music/Alicia Keys - HERE (Deluxe 2016) [24-44 HD FLAC]/02. The Gospel.flac","trackType":"flac"} Feb 11 17:09:52 volumiotest volumio[1385]: verbose: CURRENT POSITION 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::syncState stateService play Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::syncState currentStatus play Feb 11 17:09:52 volumiotest volumio[1385]: info: Received an update from plugin. extracting info from payload Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:09:52 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:09:52 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:09:52 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:09:52 volumiotest volumio[1385]: info: ------------------------------ 203ms Feb 11 17:09:53 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:54 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:55 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:57 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:58 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:09:59 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:00 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:01 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:02 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:03 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:04 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:06 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:07 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:08 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:09 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:10 volumiotest volumio[1385]: info: Preload queue cleared Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::ClearQueue Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::stop Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::stPlaybackTimer Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::updateTrackBlock Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrackBlock Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::serviceStop Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::serviceStop Feb 11 17:10:10 volumiotest volumio[1385]: info: ControllerMpd::stop Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::clearPlayQueue Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::saveQueue Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushQueue Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::addQueueItems Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::addQueueItems Feb 11 17:10:10 volumiotest volumio[1385]: info: Preload queue cleared Feb 11 17:10:10 volumiotest volumio[1385]: info: Adding Item to queue: music-library/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1] Feb 11 17:10:10 volumiotest volumio[1385]: info: Exploding uri music-library/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1] in service mpd Feb 11 17:10:10 volumiotest volumio[1385]: info: Feb 11 17:10:10 volumiotest volumio[1385]: ---------------------------- MPD announces state update: player Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F01.%20B.B.%20King%20-%20Exactly%20Like%20You.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/01. B.B. King - Exactly Like You.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F02.%20B.B.%20King%20-%20On%20My%20Word%20Of%20Honor.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/02. B.B. King - On My Word Of Honor.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F03.%20B.B.%20King%20-%20I%20Want%20A%20Little%20Girl.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/03. B.B. King - I Want A Little Girl.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F04.%20B.B.%20King%20-%20I'll%20String%20Along%20With%20You.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/04. B.B. King - I'll String Along With You.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F05.%20B.B.%20King%20-%20I%20Need%20You%20So.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/05. B.B. King - I Need You So.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F06.%20B.B.%20King%20-%20A%20Mother's%20Love.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/06. B.B. King - A Mother's Love.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F07.%20B.B.%20King%20-%20(I%20Love%20You)%20For%20Sentimental%20Reasons.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/07. B.B. King - (I Love You) For Sentimental Reasons.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F08.%20B.B.%20King%20-%20Neighborhood%20Affair.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/08. B.B. King - Neighborhood Affair.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F09.%20B.B.%20King%20-%20Tomorrow%20Night.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/09. B.B. King - Tomorrow Night.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F10.%20B.B.%20King%20-%20There%20I've%20Said%20It%20Again.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/10. B.B. King - There I've Said It Again.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F11.%20B.B.%20King%20-%20Always%20On%20My%20Mind.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/11. B.B. King - Always On My Mind.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F12.%20B.B.%20King%20-%20Cross%20My%20Heart.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/12. B.B. King - Cross My Heart.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King/Reflections/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20-%20Reflections%20(2003%20-%20Blues)%20%5BFlac%2024-88%20SACD%205.1%5D%2F13.%20B.B.%20King%20-%20What%20A%20Wonderful%20World.flac&metadata=false Feb 11 17:10:10 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/13. B.B. King - What A Wonderful World.flac Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand stop took 157 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: info: ControllerMpd::getState Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand status Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushQueue Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::saveQueue Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::updateTrackBlock Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrackBlock Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 1 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: play , [object Object] Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPlay Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::play index 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::stop Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::play index undefined Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::startPlaybackTimer Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::clearAddPlayTracks NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/01. B.B. King - Exactly Like You.flac Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand status took 24 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand stop took 2 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::parseState Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 17:10:10 volumiotest volumio[1385]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 11 17:10:10 volumiotest volumio[1385]: info: Feb 11 17:10:10 volumiotest volumio[1385]: ---------------------------- MPD announces system playlist update Feb 11 17:10:10 volumiotest volumio[1385]: info: Ignoring MPD Status Update Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand clear took 17 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::parseTrackInfo Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand add "NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/01. B.B. King - Exactly Like You.flac" Feb 11 17:10:10 volumiotest volumio[1385]: info: ControllerMpd::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::servicePushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: 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":"The Gospel","artist":"Alicia Keys","album":"HERE","uri":"NAS/Music/Alicia Keys - HERE (Deluxe 2016) [24-44 HD FLAC]/02. The Gospel.flac","trackType":"flac"} Feb 11 17:10:10 volumiotest volumio[1385]: verbose: CURRENT POSITION 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::syncState stateService stop Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::syncState currentStatus stop Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: No code Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:10 volumiotest volumio[1385]: info: ------------------------------ 199ms Feb 11 17:10:10 volumiotest volumio[1385]: error: updateQueue error: null Feb 11 17:10:10 volumiotest volumio[1385]: info: Feb 11 17:10:10 volumiotest volumio[1385]: ---------------------------- MPD announces system playlist update Feb 11 17:10:10 volumiotest volumio[1385]: info: Ignoring MPD Status Update Feb 11 17:10:10 volumiotest volumio[1385]: info: ------------------------------ 146ms Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand add "NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/01. B.B. King - Exactly Like You.flac" took 142 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand play Feb 11 17:10:10 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -5 Feb 11 17:10:10 volumiotest volumio[1385]: info: Feb 11 17:10:10 volumiotest volumio[1385]: ---------------------------- MPD announces state update: player Feb 11 17:10:10 volumiotest volumio[1385]: info: ------------------------------ 151ms Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand play took 149 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: info: ControllerMpd::getState Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand status Feb 11 17:10:10 volumiotest volumio[1385]: info: Feb 11 17:10:10 volumiotest volumio[1385]: ---------------------------- MPD announces state update: player Feb 11 17:10:10 volumiotest volumio[1385]: info: ControllerMpd::getState Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand status Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand status took 19 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::parseState Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand status took 16 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand playlistinfo took 14 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::parseState Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::parseTrackInfo Feb 11 17:10:10 volumiotest volumio[1385]: info: ControllerMpd::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::servicePushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/01. B.B. King - Exactly Like You.flac","trackType":"flac"} Feb 11 17:10:10 volumiotest volumio[1385]: verbose: CURRENT POSITION 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::syncState stateService play Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::syncState currentStatus stop Feb 11 17:10:10 volumiotest volumio[1385]: info: ------------------------------ 51ms Feb 11 17:10:10 volumiotest volumio[1385]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 11 17:10:10 volumiotest volumio[1385]: verbose: ControllerMpd::parseTrackInfo Feb 11 17:10:10 volumiotest volumio[1385]: info: ControllerMpd::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::servicePushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":199,"samplerate":"88.2 kHz","bitdepth":"24 bit","channels":6,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Exactly Like You","artist":"B.B. King","album":"Reflections","uri":"NAS/Music/B.B. King - Reflections (2003 - Blues) [Flac 24-88 SACD 5.1]/01. B.B. King - Exactly Like You.flac","trackType":"flac"} Feb 11 17:10:10 volumiotest volumio[1385]: verbose: CURRENT POSITION 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::syncState stateService play Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::syncState currentStatus play Feb 11 17:10:10 volumiotest volumio[1385]: info: Received an update from plugin. extracting info from payload Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:10:10 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:10:10 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:10 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:11 volumiotest volumio[1385]: info: ------------------------------ 189ms Feb 11 17:10:11 volumiotest volumio[1385]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 11 17:10:11 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:13 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:15 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:16 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:17 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:18 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:19 volumiotest volumio[1385]: info: Preload queue cleared Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::ClearQueue Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::stop Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::stPlaybackTimer Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::updateTrackBlock Feb 11 17:10:19 volumiotest volumio[1385]: info: CorePlayQueue::getTrackBlock Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::pushState Feb 11 17:10:19 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushState Feb 11 17:10:19 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output update for this device Feb 11 17:10:19 volumiotest volumio[1385]: info: MRS: Pushing multiroomSync output Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreCommandRouter::volumioGetState Feb 11 17:10:19 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::serviceStop Feb 11 17:10:19 volumiotest volumio[1385]: info: CorePlayQueue::getTrack 0 Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreCommandRouter::serviceStop Feb 11 17:10:19 volumiotest volumio[1385]: info: ControllerMpd::stop Feb 11 17:10:19 volumiotest volumio[1385]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 17:10:19 volumiotest volumio[1385]: info: CorePlayQueue::clearPlayQueue Feb 11 17:10:19 volumiotest volumio[1385]: info: CorePlayQueue::saveQueue Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreCommandRouter::volumioPushQueue Feb 11 17:10:19 volumiotest volumio[1385]: info: CoreStateMachine::addQueueItems Feb 11 17:10:19 volumiotest volumio[1385]: info: CorePlayQueue::addQueueItems Feb 11 17:10:19 volumiotest volumio[1385]: info: Preload queue cleared Feb 11 17:10:19 volumiotest volumio[1385]: info: Adding Item to queue: music-library/NAS/Music/B.B. King & Eric Clapton - Riding With The King (2015) Audio Fidelity SACD FLAC Beolab1700 Feb 11 17:10:19 volumiotest volumio[1385]: info: Exploding uri music-library/NAS/Music/B.B. King & Eric Clapton - Riding With The King (2015) Audio Fidelity SACD FLAC Beolab1700 in service mpd Feb 11 17:10:19 volumiotest volumio[1385]: info: Feb 11 17:10:19 volumiotest volumio[1385]: ---------------------------- MPD announces state update: player Feb 11 17:10:19 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King%20%26%20Eric%20Clapton/Riding%20With%20The%20King%20%5B2015%20Audio%20Fidelity%20SACD%20AFZ%20211%5D/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20%26%20Eric%20Clapton%20-%20Riding%20With%20The%20King%20(2015)%20Audio%20Fidelity%20SACD%20FLAC%20Beolab1700%2FB.B.%20King%20%26%20Eric%20Clapton%20-%20Riding%20With%20The%20King%20%5B2015%20Audio%20Fidelity%20SACD%20AFZ%20211%5D.cue&metadata=false Feb 11 17:10:19 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King & Eric Clapton - Riding With The King (2015) Audio Fidelity SACD FLAC Beolab1700/B.B. King & Eric Clapton - Riding With The King [2015 Audio Fidelity SACD AFZ 211].cue Feb 11 17:10:19 volumiotest volumio[1385]: info: ALBUMART /albumart?cacheid=104&web=B.B.%20King%20%26%20Eric%20Clapton/Riding%20With%20The%20King%20%5B2015%20Audio%20Fidelity%20SACD%20AFZ%20211%5D/large&path=%2Fmnt%2FNAS%2FMusic%2FB.B.%20King%20%26%20Eric%20Clapton%20-%20Riding%20With%20The%20King%20(2015)%20Audio%20Fidelity%20SACD%20FLAC%20Beolab1700%2FB.B.%20King%20%26%20Eric%20Clapton%20-%20Riding%20With%20The%20King%20%5B2015%20Audio%20Fidelity%20SACD%20AFZ%20211%5D.cue&metadata=false Feb 11 17:10:19 volumiotest volumio[1385]: info: URI /mnt/NAS/Music/B.B. King & Eric Clapton - Riding With The King (2015) Audio Fidelity SACD FLAC Beolab1700/B.B. King & Eric Clapton - Riding With The King [2015 Audio Fidelity SACD AFZ 211].cue Feb 11 17:10:19 volumiotest volumio[1385]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 17:10:19 volumiotest volumio[1385]: Error: Unable to resolve or reject the same promise twice Feb 11 17:10:19 volumiotest volumio[1385]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 11 17:10:19 volumiotest volumio[1385]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Feb 11 17:10:19 volumiotest volumio[1385]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Feb 11 17:10:19 volumiotest volumio[1385]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Feb 11 17:10:19 volumiotest volumio[1385]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Feb 11 17:10:19 volumiotest volumio[1385]: at Socket.emit (node:events:514:28) Feb 11 17:10:19 volumiotest volumio[1385]: at addChunk (node:internal/streams/readable:343:12) Feb 11 17:10:19 volumiotest volumio[1385]: at readableAddChunk (node:internal/streams/readable:312:11) Feb 11 17:10:19 volumiotest volumio[1385]: at Readable.push (node:internal/streams/readable:253:10) Feb 11 17:10:19 volumiotest volumio[1385]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Feb 11 17:10:19 volumiotest volumio[1385]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 17:10:19 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:21 volumiotest kernel: edt_ft5x06 10-0038: Unable to fetch data, error: -110 Feb 11 17:10:21 volumiotest sudo[6303]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-11 17:09' Feb 11 17:10:21 volumiotest sudo[6303]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"