Oct 28 21:01:05 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:05 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:05 volumio volumio[916]: info: Listing playlists Oct 28 21:01:05 volumio volumio[916]: info: Listing playlists Oct 28 21:01:07 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:07 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioNext Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::next Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::stPlaybackTimer Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::serviceStop Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::serviceStop Oct 28 21:01:11 volumio volumio[916]: info: ControllerMpd::stop Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:11 volumio volumio[916]: info: sendMpdCommand stop took 8 milliseconds Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:01:11 volumio volumio[916]: info: Oct 28 21:01:11 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:11 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:11 volumio volumio[916]: info: Oct 28 21:01:11 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:11 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:11 volumio volumio[916]: info: Oct 28 21:01:11 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:11 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:11 volumio volumio[916]: info: sendMpdCommand status took 4 milliseconds Oct 28 21:01:11 volumio volumio[916]: info: sendMpdCommand status took 3 milliseconds Oct 28 21:01:11 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:11 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:11 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:11 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:11 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:11 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:11 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: No code Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:11 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: No code Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:11 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: No code Oct 28 21:01:11 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:11 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:11 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:11 volumio volumio[916]: info: ------------------------------ 52ms Oct 28 21:01:11 volumio volumio[916]: info: ------------------------------ 51ms Oct 28 21:01:11 volumio volumio[916]: info: ------------------------------ 51ms Oct 28 21:01:15 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:15 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::startPlaybackTimer Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand stop took 0 milliseconds Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand clear Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:16 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand clear took 1 milliseconds Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:16 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:16 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:16 volumio volumio[916]: error: updateQueue error: null Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:16 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 6ms Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" took 5 milliseconds Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand play Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 10ms Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 9ms Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:16 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:16 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 14ms Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand play took 14 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 8ms Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 13ms Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand status took 14 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand status took 16 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand status took 14 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand status took 4 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"857 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:16 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 26ms Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:16 volumio volumio[916]: info: Oct 28 21:01:16 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:16 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:16 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:16 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:16 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:16 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:16 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 67ms Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 66ms Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 56ms Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand status took 47 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand status took 46 milliseconds Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 28 21:01:16 volumio volumio[916]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:16 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:16 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:16 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:16 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:16 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:16 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:16 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 80ms Oct 28 21:01:16 volumio volumio[916]: info: ------------------------------ 79ms Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioNext Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::next Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::stPlaybackTimer Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::serviceStop Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::serviceStop Oct 28 21:01:18 volumio volumio[916]: info: ControllerMpd::stop Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:18 volumio volumio[916]: info: sendMpdCommand stop took 8 milliseconds Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:01:18 volumio volumio[916]: info: Oct 28 21:01:18 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:18 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:18 volumio volumio[916]: info: Oct 28 21:01:18 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:18 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:18 volumio volumio[916]: info: Oct 28 21:01:18 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:18 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:18 volumio volumio[916]: info: sendMpdCommand status took 3 milliseconds Oct 28 21:01:18 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:01:18 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:18 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:18 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:18 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:18 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:18 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:18 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: No code Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:18 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: No code Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:18 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: No code Oct 28 21:01:18 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:18 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:18 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:18 volumio volumio[916]: info: ------------------------------ 42ms Oct 28 21:01:18 volumio volumio[916]: info: ------------------------------ 42ms Oct 28 21:01:18 volumio volumio[916]: info: ------------------------------ 41ms Oct 28 21:01:25 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:25 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:25 volumio volumio[916]: info: Listing playlists Oct 28 21:01:25 volumio volumio[916]: info: Listing playlists Oct 28 21:01:28 volumio volumio[916]: info: CoreCommandRouter::volumioRemoveQueueItem Oct 28 21:01:28 volumio volumio[916]: info: CoreStateMachine::removeQueueItem Oct 28 21:01:28 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:28 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:28 volumio volumio[916]: info: CorePlayQueue::removeQueueItem 0 Oct 28 21:01:28 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:28 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:31 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:31 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:35 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:35 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:36 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 28 21:01:36 volumio volumio[916]: info: CURURI: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:36 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:38 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:38 volumio volumio[916]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::ClearQueue Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::clearPlayQueue Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:38 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:38 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0001 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0001 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0002 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0002 Oct 28 21:01:38 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:38 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::play index 1 Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:38 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0003 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0003 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0004 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0004 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0005 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0005 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0006 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0006 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0007 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0007 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0008 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0008 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0009 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0009 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0010 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0010 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0011 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0011 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0012 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0012 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0013 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0013 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0014 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0014 Oct 28 21:01:38 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0015 Oct 28 21:01:38 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0015 Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:38 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:38 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:38 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:01:40 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:40 volumio volumio[916]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::ClearQueue Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::clearPlayQueue Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:40 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:40 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0001 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0001 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0002 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0002 Oct 28 21:01:40 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:40 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::play index 1 Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:40 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0003 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0003 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0004 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0004 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0005 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0005 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0006 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0006 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0007 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0007 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0008 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0008 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0009 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0009 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0010 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0010 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0011 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0011 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0012 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0012 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0013 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0013 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0014 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0014 Oct 28 21:01:40 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0015 Oct 28 21:01:40 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue/track0015 Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:40 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:40 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:40 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:01:44 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::ClearQueue Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::clearPlayQueue Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:44 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:44 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:44 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::play index 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::startPlaybackTimer Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand stop took 2 milliseconds Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand clear Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand clear took 1 milliseconds Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:44 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:44 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:44 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:44 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" took 10 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 10ms Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 8ms Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand play Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:44 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:44 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 15ms Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 13ms Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand play took 13 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 15ms Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 15ms Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand status took 14 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand status took 11 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand status took 10 milliseconds Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:44 volumio volumio[916]: info: Oct 28 21:01:44 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand status took 20 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand playlistinfo took 14 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand status took 9 milliseconds Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:44 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":366,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"940 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:44 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:44 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":458,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"810 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:44 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:44 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 75ms Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 76ms Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 74ms Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand status took 54 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand playlistinfo took 46 milliseconds Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand playlistinfo took 43 milliseconds Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:44 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:44 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:44 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:44 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 92ms Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 81ms Oct 28 21:01:44 volumio volumio[916]: info: sendMpdCommand playlistinfo took 33 milliseconds Oct 28 21:01:44 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:44 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:44 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:44 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:44 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:44 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:44 volumio volumio[916]: info: ------------------------------ 98ms Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: Listing playlists Oct 28 21:01:45 volumio volumio[916]: info: Listing playlists Oct 28 21:01:45 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:45 volumio volumio[916]: info: Oct 28 21:01:45 volumio volumio[916]: [1761674505865] ---------------------------- Client requests add and Play Volumio CUE entry Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Oct 28 21:01:45 volumio volumio[916]: info: Adding CUE individual entry: 0 USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioAddQueueItems Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:45 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:45 volumio volumio[916]: info: Adding Item to queue: cue://USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue@0 Oct 28 21:01:45 volumio volumio[916]: info: Exploding uri cue://USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue@0 in service mpd Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::play index 1 Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::stPlaybackTimer Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::serviceStop Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::serviceStop Oct 28 21:01:45 volumio volumio[916]: info: ControllerMpd::stop Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:45 volumio volumio[916]: info: Oct 28 21:01:45 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:45 volumio volumio[916]: info: sendMpdCommand stop took 13 milliseconds Oct 28 21:01:45 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:01:45 volumio volumio[916]: info: Oct 28 21:01:45 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:45 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:45 volumio volumio[916]: info: Oct 28 21:01:45 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:45 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:45 volumio volumio[916]: info: sendMpdCommand status took 4 milliseconds Oct 28 21:01:45 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:01:45 volumio volumio[916]: info: sendMpdCommand status took 1 milliseconds Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:45 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:45 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:45 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:45 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:45 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:45 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: No code Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:45 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: No code Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:45 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: No code Oct 28 21:01:45 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:45 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:45 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:45 volumio volumio[916]: info: ------------------------------ 43ms Oct 28 21:01:45 volumio volumio[916]: info: ------------------------------ 42ms Oct 28 21:01:45 volumio volumio[916]: info: ------------------------------ 43ms Oct 28 21:01:47 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:47 volumio volumio[916]: info: Oct 28 21:01:47 volumio volumio[916]: [1761674507317] ---------------------------- Client requests add and Play Volumio CUE entry Oct 28 21:01:47 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Oct 28 21:01:47 volumio volumio[916]: info: Adding CUE individual entry: 0 USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:47 volumio volumio[916]: info: CoreCommandRouter::volumioAddQueueItems Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:47 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:47 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:47 volumio volumio[916]: info: Adding Item to queue: cue://USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue@0 Oct 28 21:01:47 volumio volumio[916]: info: Exploding uri cue://USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue@0 in service mpd Oct 28 21:01:47 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::play index 1 Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:47 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:01:47 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:47 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:47 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:47 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:49 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::ClearQueue Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::clearPlayQueue Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:49 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:49 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:49 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::play index 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::startPlaybackTimer Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand stop took 2 milliseconds Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand clear Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand clear took 0 milliseconds Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:49 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:49 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:49 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:49 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:49 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" took 10 milliseconds Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 11ms Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 10ms Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 9ms Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand play Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:49 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 17ms Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 16ms Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand play took 10 milliseconds Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 12ms Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:49 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:49 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:49 volumio volumio[916]: info: Oct 28 21:01:49 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:49 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand status took 3 milliseconds Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand status took 10 milliseconds Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand status took 10 milliseconds Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand playlistinfo took 11 milliseconds Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:49 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:49 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 26ms Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 28 21:01:49 volumio volumio[916]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:49 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:49 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:49 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:49 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:49 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:49 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:49 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:49 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:49 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:49 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 63ms Oct 28 21:01:49 volumio volumio[916]: info: ------------------------------ 64ms Oct 28 21:01:53 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::ClearQueue Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::stPlaybackTimer Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::serviceStop Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::serviceStop Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::stop Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::clearPlayQueue Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:01:53 volumio volumio[916]: info: Preload queue cleared Oct 28 21:01:53 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:53 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::play index 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::startPlaybackTimer Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand stop took 17 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand stop took 4 milliseconds Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand clear Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:53 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 6 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand clear took 5 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 5 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 3 milliseconds Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: No code Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: No code Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 31ms Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 31ms Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:53 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:53 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:53 volumio volumio[916]: error: updateQueue error: null Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:53 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 37ms Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand playlistinfo took 36 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" took 36 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 9ms Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 8ms Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand play Oct 28 21:01:53 volumio volumio[916]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 46ms Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:53 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:01:53 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 28ms Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand play took 24 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 23ms Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 23ms Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 8 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 7 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 6 milliseconds Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: Oct 28 21:01:53 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 7 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 5 milliseconds Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":733,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:53 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:53 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 33ms Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 38ms Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 38ms Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand status took 29 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand playlistinfo took 23 milliseconds Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:53 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:53 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 57ms Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 54ms Oct 28 21:01:53 volumio volumio[916]: info: sendMpdCommand playlistinfo took 32 milliseconds Oct 28 21:01:53 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:53 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:53 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:01:53 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:53 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:53 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:53 volumio volumio[916]: info: ------------------------------ 72ms Oct 28 21:01:55 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:01:55 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioNext Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::next Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::stPlaybackTimer Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::serviceStop Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::serviceStop Oct 28 21:01:56 volumio volumio[916]: info: ControllerMpd::stop Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:01:56 volumio volumio[916]: info: sendMpdCommand stop took 8 milliseconds Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:01:56 volumio volumio[916]: info: Oct 28 21:01:56 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:56 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:56 volumio volumio[916]: info: Oct 28 21:01:56 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:56 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:56 volumio volumio[916]: info: Oct 28 21:01:56 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:01:56 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:01:56 volumio volumio[916]: info: sendMpdCommand status took 3 milliseconds Oct 28 21:01:56 volumio volumio[916]: info: sendMpdCommand status took 3 milliseconds Oct 28 21:01:56 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:01:56 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:56 volumio volumio[916]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 28 21:01:56 volumio volumio[916]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:56 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:01:56 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:56 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: No code Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:56 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: No code Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:01:56 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: No code Oct 28 21:01:56 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:01:56 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:01:56 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:01:56 volumio volumio[916]: info: ------------------------------ 41ms Oct 28 21:01:56 volumio volumio[916]: info: ------------------------------ 41ms Oct 28 21:01:56 volumio volumio[916]: info: ------------------------------ 41ms Oct 28 21:02:00 volumio volumio[916]: info: Preload queue cleared Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::ClearQueue Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::clearPlayQueue Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:02:00 volumio volumio[916]: info: Preload queue cleared Oct 28 21:02:00 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:02:00 volumio volumio[916]: info: Using cached record of: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPlay Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::play index 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::startPlaybackTimer Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand stop took 5 milliseconds Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand clear Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:02:00 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand clear took 1 milliseconds Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" Oct 28 21:02:00 volumio volumio[916]: error: updateQueue error: null Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 2ms Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:02:00 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:02:00 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:02:00 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand load "USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/MODE- 1993-2005.cue" took 6 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 4ms Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand play Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:02:00 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces system playlist update Oct 28 21:02:00 volumio volumio[916]: info: Ignoring MPD Status Update Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 12ms Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 10ms Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand play took 8 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 8ms Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 9ms Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand status took 11 milliseconds Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand status took 13 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand status took 12 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"857 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:00 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 22ms Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:00 volumio volumio[916]: info: Oct 28 21:02:00 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand status took 13 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand status took 5 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand status took 3 milliseconds Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":481,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"762 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:00 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:02:00 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"762 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:00 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:02:00 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 54ms Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 52ms Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand playlistinfo took 28 milliseconds Oct 28 21:02:00 volumio volumio[916]: info: sendMpdCommand playlistinfo took 29 milliseconds Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:00 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:00 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:02:00 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:00 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:02:00 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"891 Kbps","isStreaming":false,"title":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:00 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState stateService play Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus play Oct 28 21:02:00 volumio volumio[916]: info: Received an update from plugin. extracting info from payload Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:00 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:00 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 71ms Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 63ms Oct 28 21:02:00 volumio volumio[916]: info: ------------------------------ 62ms Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioNext Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::next Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::stPlaybackTimer Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::updateTrackBlock Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrackBlock Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::serviceStop Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::serviceStop Oct 28 21:02:03 volumio volumio[916]: info: ControllerMpd::stop Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand stop Oct 28 21:02:03 volumio volumio[916]: info: Oct 28 21:02:03 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:03 volumio volumio[916]: info: sendMpdCommand stop took 9 milliseconds Oct 28 21:02:03 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::play index undefined Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 1 Oct 28 21:02:03 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:03 volumio volumio[916]: info: Oct 28 21:02:03 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:03 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:03 volumio volumio[916]: info: Oct 28 21:02:03 volumio volumio[916]: ---------------------------- MPD announces state update: player Oct 28 21:02:03 volumio volumio[916]: info: ControllerMpd::getState Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand status Oct 28 21:02:03 volumio volumio[916]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 28 21:02:03 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:02:03 volumio volumio[916]: info: sendMpdCommand status took 2 milliseconds Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::parseState Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 28 21:02:03 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:03 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: No code Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: ------------------------------ 18ms Oct 28 21:02:03 volumio volumio[916]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 28 21:02:03 volumio volumio[916]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:03 volumio volumio[916]: verbose: ControllerMpd::parseTrackInfo Oct 28 21:02:03 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:03 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: No code Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: ControllerMpd::pushState Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::servicePushState Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: 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":"My Joy [Seven Inch Mix]","artist":"Depeche Mode","album":"MODE: 1993-2005","uri":"USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD17 - D (1993-2005)/01 My Joy [Seven Inch Mix].flac","trackType":"flac"} Oct 28 21:02:03 volumio volumio[916]: verbose: CURRENT POSITION 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::syncState stateService stop Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::syncState currentStatus stop Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: No code Oct 28 21:02:03 volumio volumio[916]: info: CoreStateMachine::pushState Oct 28 21:02:03 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:03 volumio volumio[916]: info: CoreCommandRouter::volumioPushState Oct 28 21:02:03 volumio volumio[916]: info: ------------------------------ 39ms Oct 28 21:02:03 volumio volumio[916]: info: ------------------------------ 39ms Oct 28 21:02:05 volumio volumio[916]: info: CoreCommandRouter::volumioGetState Oct 28 21:02:05 volumio volumio[916]: info: CorePlayQueue::getTrack 0 Oct 28 21:02:05 volumio volumio[916]: info: Listing playlists Oct 28 21:02:05 volumio volumio[916]: info: Listing playlists Oct 28 21:02:09 volumio volumio[916]: info: Preload queue cleared Oct 28 21:02:09 volumio volumio[916]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 28 21:02:09 volumio volumio[916]: info: CoreStateMachine::ClearQueue Oct 28 21:02:09 volumio volumio[916]: info: CoreStateMachine::stop Oct 28 21:02:09 volumio volumio[916]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 28 21:02:09 volumio volumio[916]: info: CorePlayQueue::clearPlayQueue Oct 28 21:02:09 volumio volumio[916]: info: CorePlayQueue::saveQueue Oct 28 21:02:09 volumio volumio[916]: info: CoreCommandRouter::volumioPushQueue Oct 28 21:02:09 volumio volumio[916]: info: CoreStateMachine::addQueueItems Oct 28 21:02:09 volumio volumio[916]: info: CorePlayQueue::addQueueItems Oct 28 21:02:09 volumio volumio[916]: info: Preload queue cleared Oct 28 21:02:09 volumio volumio[916]: info: Adding Item to queue: music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra Oct 28 21:02:09 volumio volumio[916]: info: Exploding uri music-library/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra in service mpd Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F01%20Barrel%20of%20a%20Gun.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/01 Barrel of a Gun.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F02%20The%20Love%20Thieves.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/02 The Love Thieves.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F03%20Home.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/03 Home.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F04%20It's%20No%20Good.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/04 It's No Good.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F05%20Uselink.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/05 Uselink.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F06%20Useless.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/06 Useless.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F07%20Sister%20of%20Night.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/07 Sister of Night.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F08%20Jazz%20Thieves.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/08 Jazz Thieves.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F09%20Freestate.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/09 Freestate.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F10%20The%20Bottom%20Line.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/10 The Bottom Line.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F11%20Insight.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/11 Insight.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2F12%20Junior%20Painkiller.flac&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/12 Junior Painkiller.flac Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2FMODE-%20Ultra.cue&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/MODE- Ultra.cue Oct 28 21:02:09 volumio volumio[916]: info: ALBUMART /albumart?cacheid=951&web=Depeche%20Mode/MODE%3A%20Ultra/extralarge&path=%2Fmnt%2FUSB%2F0F8A-0C3B%2FDepeche%20Mode%20-%20MODE%20(2020)%20%5BFLAC%5D%2FCD09%20-%20Ultra%2FMODE-%20Ultra.cue&metadata=false Oct 28 21:02:09 volumio volumio[916]: info: URI /mnt/USB/0F8A-0C3B/Depeche Mode - MODE (2020) [FLAC]/CD09 - Ultra/MODE- Ultra.cue Oct 28 21:02:09 volumio volumio[916]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 21:02:10 volumio volumio[916]: Error: Unable to resolve or reject the same promise twice Oct 28 21:02:10 volumio volumio[916]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 28 21:02:10 volumio volumio[916]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Oct 28 21:02:10 volumio volumio[916]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 28 21:02:10 volumio volumio[916]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 28 21:02:10 volumio volumio[916]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 28 21:02:10 volumio volumio[916]: at Socket.emit (node:events:514:28) Oct 28 21:02:10 volumio volumio[916]: at addChunk (node:internal/streams/readable:343:12) Oct 28 21:02:10 volumio volumio[916]: at readableAddChunk (node:internal/streams/readable:312:11) Oct 28 21:02:10 volumio volumio[916]: at Readable.push (node:internal/streams/readable:253:10) Oct 28 21:02:10 volumio volumio[916]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Oct 28 21:02:10 volumio volumio[916]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 28 21:02:12 volumio sudo[3959]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-10-28 21:01' Oct 28 21:02:12 volumio sudo[3959]: 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="5ef3d56f987d109f3e21bfa246dbbb723cf6a917" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="c7bff9654d2984a81c5720476c2c8ac531869c54" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Oct 9 18:08:11 UTC 2025" VOLUMIO_VERSION="4.062" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="00524295c246b7d72f125e4c54b86a88"