-- Logs begin at Sun 2024-07-14 19:44:49 EEST, end at Sun 2024-10-06 22:34:52 EEST. -- Oct 06 22:33:01 volumio volumio[1023]: error: Cue Parser - Cannot parse NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:33:01 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:33:01 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:33:01 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:01 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 45ms Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand status took 43 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 41ms Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand status took 37 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 37ms Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand status took 42 milliseconds Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:01 volumio volumio[1023]: info: Oct 06 22:33:01 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:01 volumio volumio[1023]: Upnp client error: Error: This socket has been ended by the other party Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand status took 35 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 19 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand status took 12 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand status took 9 milliseconds Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2960,"duration":212,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1355 Kbps","isStreaming":false,"title":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:01 volumio volumio[1023]: verbose: CURRENT POSITION 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:33:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2960,"duration":212,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1386 Kbps","isStreaming":false,"title":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:01 volumio volumio[1023]: verbose: CURRENT POSITION 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:33:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2960,"duration":212,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1386 Kbps","isStreaming":false,"title":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:01 volumio volumio[1023]: verbose: CURRENT POSITION 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:33:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 216ms Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 211ms Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 207ms Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 142 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 138 milliseconds Oct 06 22:33:01 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 138 milliseconds Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:01 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2960,"duration":212,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1386 Kbps","isStreaming":false,"title":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:01 volumio volumio[1023]: verbose: CURRENT POSITION 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:33:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2960,"duration":212,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1386 Kbps","isStreaming":false,"title":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:01 volumio volumio[1023]: verbose: CURRENT POSITION 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:33:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2960,"duration":212,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1386 Kbps","isStreaming":false,"title":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:01 volumio volumio[1023]: verbose: CURRENT POSITION 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:33:01 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 265ms Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 238ms Oct 06 22:33:01 volumio volumio[1023]: info: ------------------------------ 234ms Oct 06 22:33:05 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 22:33:05 volumio volumio[1023]: info: CURURI: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:33:05 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0001 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0002 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0003 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0004 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0005 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0006 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0007 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0008 Oct 06 22:33:05 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0009 Oct 06 22:33:05 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0001 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0001' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0002 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0002' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0003 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0003' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0004 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0004' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0005 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0005' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0006 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0006' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0007 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0007' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0008 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0008' Oct 06 22:33:07 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0009 in service mpd Oct 06 22:33:07 volumio volumio[1023]: error: scanFolder - failure to stat '/mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0009' Oct 06 22:33:08 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::stPlaybackTimer Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::serviceStop Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::serviceStop Oct 06 22:33:08 volumio volumio[1023]: info: ControllerMpd::stop Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:33:08 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0001 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0001 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0002 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0002 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0003 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0003 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0004 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0004 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0005 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0005 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0006 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0006 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0007 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0007 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0008 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0008 Oct 06 22:33:08 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0009 Oct 06 22:33:08 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0009 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::play index 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: Oct 06 22:33:08 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:08 volumio volumio[1023]: info: sendMpdCommand stop took 24 milliseconds Oct 06 22:33:08 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:08 volumio volumio[1023]: info: Oct 06 22:33:08 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:08 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:08 volumio volumio[1023]: info: Oct 06 22:33:08 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:33:08 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:33:08 volumio volumio[1023]: info: sendMpdCommand status took 4 milliseconds Oct 06 22:33:08 volumio volumio[1023]: info: sendMpdCommand status took 2 milliseconds Oct 06 22:33:08 volumio volumio[1023]: info: sendMpdCommand status took 1 milliseconds Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:33:08 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 06 22:33:08 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 06 22:33:08 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:08 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:33:08 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: 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":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:08 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: No code Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: 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":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:08 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: No code Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: 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":"Desperado","artist":"Diana Krall","album":"Wallflower","uri":"NAS/NAS1/Diana Krall/Diana Krall - Wallflower (2015)/02-Desperado.flac","trackType":"flac"} Oct 06 22:33:08 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::syncState stateService stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: No code Oct 06 22:33:08 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:33:08 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:08 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:33:08 volumio volumio[1023]: info: ------------------------------ 90ms Oct 06 22:33:08 volumio volumio[1023]: info: ------------------------------ 89ms Oct 06 22:33:08 volumio volumio[1023]: info: ------------------------------ 89ms Oct 06 22:33:16 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:33:16 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:33:16 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:16 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:33:16 volumio kernel: hwmon hwmon1: Voltage normalised Oct 06 22:33:19 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:19 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:19 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:33:19 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:33:19 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:33:19 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:33:19 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0001 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0001 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0002 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0002 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0003 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0003 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0004 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0004 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0005 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0005 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0006 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0006 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0007 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0007 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0008 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0008 Oct 06 22:33:19 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0009 Oct 06 22:33:19 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue/track0009 Oct 06 22:33:19 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:33:19 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:33:19 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:33:19 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::play index 1 Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:33:19 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:19 volumio volumio[1023]: info: CorePlayQueue::getTrack 1 Oct 06 22:33:27 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:27 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:33:27 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:33:27 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:33:27 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:33:27 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:33:27 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:33:27 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:33:27 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:33:27 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:33:27 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:27 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:33:27 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue in service mpd Oct 06 22:33:27 volumio volumio[1023]: error: The value "windows-1252" is invalid for option "encoding" {"code":"ERR_INVALID_OPT_VALUE_ENCODING"} Oct 06 22:33:27 volumio volumio[1023]: error: Cue Parser - Cannot parse /mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:33:33 volumio volumio[1023]: info: Listing playlists Oct 06 22:33:38 volumio volumio[1023]: info: CoreCommandRouter::volumioAddQueueItems Oct 06 22:33:38 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:33:38 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:33:38 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:33:38 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:33:38 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue in service mpd Oct 06 22:33:38 volumio volumio[1023]: error: The value "windows-1252" is invalid for option "encoding" {"code":"ERR_INVALID_OPT_VALUE_ENCODING"} Oct 06 22:33:38 volumio volumio[1023]: error: Cue Parser - Cannot parse /mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:33:49 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 22:33:49 volumio volumio[1023]: info: CURURI: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life Oct 06 22:33:49 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:01 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:01 volumio volumio[1023]: info: Oct 06 22:34:01 volumio volumio[1023]: [1728243241889] ---------------------------- Client requests add and Play Volumio CUE entry Oct 06 22:34:01 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , addPlayCue Oct 06 22:34:01 volumio volumio[1023]: info: Adding CUE individual entry: 0 NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue Oct 06 22:34:01 volumio volumio[1023]: info: CoreCommandRouter::volumioAddQueueItems Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:34:01 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:34:01 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:01 volumio volumio[1023]: info: Adding Item to queue: cue://NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue@0 Oct 06 22:34:01 volumio volumio[1023]: info: Exploding uri cue://NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue@0 in service mpd Oct 06 22:34:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::play index 0 Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:01 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:01 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:01 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:01 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:34:01 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:34:09 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:09 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:09 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:34:09 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:09 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:34:09 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:34:09 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:09 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue Oct 06 22:34:09 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue in service mpd Oct 06 22:34:09 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:09 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:34:09 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:34:09 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::play index 0 Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:09 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:09 volumio volumio[1023]: info: CoreStateMachine::startPlaybackTimer Oct 06 22:34:09 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:09 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 22:34:09 volumio volumio[1023]: info: sendMpdCommand stop took 2 milliseconds Oct 06 22:34:09 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand clear Oct 06 22:34:09 volumio volumio[1023]: info: Oct 06 22:34:09 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:09 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:09 volumio volumio[1023]: info: sendMpdCommand clear took 2 milliseconds Oct 06 22:34:09 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue" Oct 06 22:34:09 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:09 volumio volumio[1023]: info: ------------------------------ 1ms Oct 06 22:34:09 volumio volumio[1023]: info: Oct 06 22:34:09 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:09 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:09 volumio volumio[1023]: info: Oct 06 22:34:09 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:09 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:09 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:09 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:09 volumio volumio[1023]: info: ------------------------------ 2ms Oct 06 22:34:09 volumio volumio[1023]: info: ------------------------------ 2ms Oct 06 22:34:09 volumio volumio[1023]: error: Upnp client error: Error: This socket has been ended by the other party Oct 06 22:34:10 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 06 22:34:13 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:13 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:13 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:34:13 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:13 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:34:13 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:34:13 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:13 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue Oct 06 22:34:13 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue Oct 06 22:34:13 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:13 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:34:13 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:34:13 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::play index 0 Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:13 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:13 volumio volumio[1023]: info: CoreStateMachine::startPlaybackTimer Oct 06 22:34:13 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:13 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 22:34:13 volumio volumio[1023]: info: sendMpdCommand stop took 1 milliseconds Oct 06 22:34:13 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand clear Oct 06 22:34:13 volumio volumio[1023]: info: Oct 06 22:34:13 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:13 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:13 volumio volumio[1023]: info: sendMpdCommand clear took 2 milliseconds Oct 06 22:34:13 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue" Oct 06 22:34:13 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:13 volumio volumio[1023]: info: ------------------------------ 2ms Oct 06 22:34:13 volumio volumio[1023]: info: Oct 06 22:34:13 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:13 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:13 volumio volumio[1023]: info: Oct 06 22:34:13 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:13 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:13 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:13 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:13 volumio volumio[1023]: info: ------------------------------ 3ms Oct 06 22:34:13 volumio volumio[1023]: info: ------------------------------ 2ms Oct 06 22:34:17 volumio kernel: hwmon hwmon1: Voltage normalised Oct 06 22:34:18 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:18 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:18 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:34:18 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:34:18 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:34:18 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:18 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue Oct 06 22:34:18 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue Oct 06 22:34:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:18 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:34:18 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:34:18 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::play index 0 Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:18 volumio volumio[1023]: info: CoreStateMachine::startPlaybackTimer Oct 06 22:34:18 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 22:34:18 volumio volumio[1023]: info: sendMpdCommand stop took 2 milliseconds Oct 06 22:34:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand clear Oct 06 22:34:18 volumio volumio[1023]: info: Oct 06 22:34:18 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:18 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:18 volumio volumio[1023]: info: sendMpdCommand clear took 2 milliseconds Oct 06 22:34:18 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS1/Sade/Sade - 1984 - 2000/1984 Diamond Life/Sade - Diamond Life (EK 85240).cue" Oct 06 22:34:18 volumio volumio[1023]: info: Oct 06 22:34:18 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:18 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:18 volumio volumio[1023]: info: Oct 06 22:34:18 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:18 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:18 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:18 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:18 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:18 volumio volumio[1023]: info: ------------------------------ 4ms Oct 06 22:34:18 volumio volumio[1023]: info: ------------------------------ 2ms Oct 06 22:34:18 volumio volumio[1023]: info: ------------------------------ 1ms Oct 06 22:34:19 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 06 22:34:24 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 22:34:24 volumio volumio[1023]: info: CURURI: music-library/NAS/NAS1/Sade/Love Deluxe Oct 06 22:34:24 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/02 Feel No Pain.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/03 I Couldn't Love You More.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/04 Like A Tattoo.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/05 Kiss Of Life.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/06 Cherish The Day.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/07 Pearls.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/08 Bullet Proof Soul.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Preloading song: music-library/NAS/NAS1/Sade/Love Deluxe/09 Mermaid.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F01%20No%20Ordinary%20Love.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/02 Feel No Pain.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F02%20Feel%20No%20Pain.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/02 Feel No Pain.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/03 I Couldn't Love You More.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F03%20I%20Couldn't%20Love%20You%20More.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/03 I Couldn't Love You More.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/04 Like A Tattoo.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F04%20Like%20A%20Tattoo.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/04 Like A Tattoo.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/05 Kiss Of Life.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F05%20Kiss%20Of%20Life.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/05 Kiss Of Life.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/06 Cherish The Day.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F06%20Cherish%20The%20Day.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/06 Cherish The Day.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/07 Pearls.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F07%20Pearls.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/07 Pearls.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/08 Bullet Proof Soul.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F08%20Bullet%20Proof%20Soul.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/08 Bullet Proof Soul.mp3 Oct 06 22:34:24 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Love Deluxe/09 Mermaid.mp3 in service mpd Oct 06 22:34:24 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FLove%20Deluxe%2F09%20Mermaid.mp3&metadata=false Oct 06 22:34:24 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Love Deluxe/09 Mermaid.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:25 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:25 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:34:25 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:25 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:34:25 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:34:25 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/02 Feel No Pain.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/02 Feel No Pain.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/03 I Couldn't Love You More.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/03 I Couldn't Love You More.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/04 Like A Tattoo.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/04 Like A Tattoo.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/05 Kiss Of Life.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/05 Kiss Of Life.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/06 Cherish The Day.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/06 Cherish The Day.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/07 Pearls.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/07 Pearls.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/08 Bullet Proof Soul.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/08 Bullet Proof Soul.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Love Deluxe/09 Mermaid.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: Using cached record of: music-library/NAS/NAS1/Sade/Love Deluxe/09 Mermaid.mp3 Oct 06 22:34:25 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:25 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:34:25 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:34:25 volumio volumio[1023]: info: CoreCommandRouter::volumioPlay Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::play index 0 Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::play index undefined Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:25 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:25 volumio volumio[1023]: info: CoreStateMachine::startPlaybackTimer Oct 06 22:34:25 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:25 volumio volumio[1023]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3 Oct 06 22:34:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 22:34:25 volumio volumio[1023]: info: sendMpdCommand stop took 3 milliseconds Oct 06 22:34:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand clear Oct 06 22:34:25 volumio volumio[1023]: info: Oct 06 22:34:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:25 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:25 volumio volumio[1023]: info: sendMpdCommand clear took 3 milliseconds Oct 06 22:34:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3" Oct 06 22:34:25 volumio volumio[1023]: error: updateQueue error: null Oct 06 22:34:25 volumio volumio[1023]: info: Oct 06 22:34:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:25 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:25 volumio volumio[1023]: info: ------------------------------ 3ms Oct 06 22:34:25 volumio volumio[1023]: info: sendMpdCommand add "NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3" took 3 milliseconds Oct 06 22:34:25 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand play Oct 06 22:34:25 volumio volumio[1023]: info: Oct 06 22:34:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:25 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:25 volumio volumio[1023]: info: Oct 06 22:34:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:25 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:25 volumio volumio[1023]: info: ------------------------------ 6ms Oct 06 22:34:25 volumio volumio[1023]: info: sendMpdCommand play took 5 milliseconds Oct 06 22:34:25 volumio volumio[1023]: info: ------------------------------ 5ms Oct 06 22:34:25 volumio volumio[1023]: info: ------------------------------ 4ms Oct 06 22:34:25 volumio volumio[1023]: info: Oct 06 22:34:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:25 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:25 volumio volumio[1023]: info: Oct 06 22:34:25 volumio volumio[1023]: ---------------------------- MPD announces system playlist update Oct 06 22:34:25 volumio volumio[1023]: info: Ignoring MPD Status Update Oct 06 22:34:25 volumio volumio[1023]: info: ------------------------------ 3ms Oct 06 22:34:25 volumio volumio[1023]: info: ------------------------------ 3ms Oct 06 22:34:26 volumio volumio[1023]: info: Oct 06 22:34:26 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:34:26 volumio volumio[1023]: info: Oct 06 22:34:26 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:34:26 volumio volumio[1023]: info: Oct 06 22:34:26 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:34:26 volumio volumio[1023]: info: Oct 06 22:34:26 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand status took 6 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand status took 4 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand status took 3 milliseconds Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:34:26 volumio volumio[1023]: info: Oct 06 22:34:26 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:34:26 volumio volumio[1023]: info: Oct 06 22:34:26 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::getState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand status Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand status took 6 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand status took 5 milliseconds Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseState Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":440,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"No Ordinary Love","artist":"Sade","album":"Love Deluxe","uri":"NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3","trackType":"mp3"} Oct 06 22:34:26 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus stop Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":440,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"No Ordinary Love","artist":"Sade","album":"Love Deluxe","uri":"NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3","trackType":"mp3"} Oct 06 22:34:26 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:34:26 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":440,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"No Ordinary Love","artist":"Sade","album":"Love Deluxe","uri":"NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3","trackType":"mp3"} Oct 06 22:34:26 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:34:26 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":440,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"No Ordinary Love","artist":"Sade","album":"Love Deluxe","uri":"NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3","trackType":"mp3"} Oct 06 22:34:26 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:34:26 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: ------------------------------ 45ms Oct 06 22:34:26 volumio volumio[1023]: info: ------------------------------ 56ms Oct 06 22:34:26 volumio volumio[1023]: info: ------------------------------ 57ms Oct 06 22:34:26 volumio volumio[1023]: info: ------------------------------ 56ms Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 41 milliseconds Oct 06 22:34:26 volumio volumio[1023]: info: sendMpdCommand playlistinfo took 42 milliseconds Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:34:26 volumio volumio[1023]: verbose: ControllerMpd::parseTrackInfo Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":440,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"No Ordinary Love","artist":"Sade","album":"Love Deluxe","uri":"NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3","trackType":"mp3"} Oct 06 22:34:26 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:34:26 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: ControllerMpd::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::servicePushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":440,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"No Ordinary Love","artist":"Sade","album":"Love Deluxe","uri":"NAS/NAS1/Sade/Love Deluxe/01 No Ordinary Love.mp3","trackType":"mp3"} Oct 06 22:34:26 volumio volumio[1023]: verbose: CURRENT POSITION 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState stateService play Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::syncState currentStatus play Oct 06 22:34:26 volumio volumio[1023]: info: Received an update from plugin. extracting info from payload Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:26 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:26 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:26 volumio volumio[1023]: info: ------------------------------ 80ms Oct 06 22:34:26 volumio volumio[1023]: info: ------------------------------ 80ms Oct 06 22:34:32 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 22:34:32 volumio volumio[1023]: info: CURURI: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000 Oct 06 22:34:32 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:33 volumio kernel: hwmon hwmon1: Voltage normalised Oct 06 22:34:34 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 06 22:34:34 volumio volumio[1023]: info: CURURI: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe Oct 06 22:34:34 volumio volumio[1023]: error: Cue Parser - Cannot parse NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:34:34 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:51 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:51 volumio volumio[1023]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::ClearQueue Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::stop Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::stPlaybackTimer Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::updateTrackBlock Oct 06 22:34:51 volumio volumio[1023]: info: CorePlayQueue::getTrackBlock Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::pushState Oct 06 22:34:51 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:51 volumio volumio[1023]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 06 22:34:51 volumio volumio[1023]: info: CoreCommandRouter::volumioPushState Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::serviceStop Oct 06 22:34:51 volumio volumio[1023]: info: CorePlayQueue::getTrack 0 Oct 06 22:34:51 volumio volumio[1023]: info: CoreCommandRouter::serviceStop Oct 06 22:34:51 volumio volumio[1023]: info: ControllerMpd::stop Oct 06 22:34:51 volumio volumio[1023]: verbose: ControllerMpd::sendMpdCommand stop Oct 06 22:34:51 volumio volumio[1023]: info: CorePlayQueue::clearPlayQueue Oct 06 22:34:51 volumio volumio[1023]: info: CorePlayQueue::saveQueue Oct 06 22:34:51 volumio volumio[1023]: info: CoreCommandRouter::volumioPushQueue Oct 06 22:34:51 volumio volumio[1023]: info: CoreStateMachine::addQueueItems Oct 06 22:34:51 volumio volumio[1023]: info: CorePlayQueue::addQueueItems Oct 06 22:34:51 volumio volumio[1023]: info: Preload queue cleared Oct 06 22:34:51 volumio volumio[1023]: info: Adding Item to queue: music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe Oct 06 22:34:51 volumio volumio[1023]: info: Exploding uri music-library/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe in service mpd Oct 06 22:34:51 volumio volumio[1023]: info: Oct 06 22:34:51 volumio volumio[1023]: ---------------------------- MPD announces state update: player Oct 06 22:34:51 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe%20(EK%2053178)/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FSade%20-%201984%20-%202000%2F1992%20Love%20Deluxe%2FSade%20-%20Love%20Deluxe%20(EK%2053178).cue&metadata=false Oct 06 22:34:51 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:34:51 volumio volumio[1023]: info: ALBUMART /albumart?cacheid=543&web=Sade/Love%20Deluxe%20(EK%2053178)/extralarge&path=%2Fmnt%2FNAS%2FNAS1%2FSade%2FSade%20-%201984%20-%202000%2F1992%20Love%20Deluxe%2FSade%20-%20Love%20Deluxe%20(EK%2053178).cue&metadata=false Oct 06 22:34:51 volumio volumio[1023]: info: URI /mnt/NAS/NAS1/Sade/Sade - 1984 - 2000/1992 Love Deluxe/Sade - Love Deluxe (EK 53178).cue Oct 06 22:34:51 volumio volumio[1023]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 22:34:51 volumio volumio[1023]: Error: Unable to resolve or reject the same promise twice Oct 06 22:34:51 volumio volumio[1023]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 06 22:34:51 volumio volumio[1023]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Oct 06 22:34:51 volumio volumio[1023]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Oct 06 22:34:51 volumio volumio[1023]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Oct 06 22:34:51 volumio volumio[1023]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Oct 06 22:34:51 volumio volumio[1023]: at Socket.emit (events.js:315:20) Oct 06 22:34:51 volumio volumio[1023]: at addChunk (internal/streams/readable.js:309:12) Oct 06 22:34:51 volumio volumio[1023]: at readableAddChunk (internal/streams/readable.js:280:11) Oct 06 22:34:51 volumio volumio[1023]: at Socket.Readable.push (internal/streams/readable.js:223:10) Oct 06 22:34:51 volumio volumio[1023]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Oct 06 22:34:51 volumio volumio[1023]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 06 22:34:52 volumio kernel: hwmon hwmon1: Undervoltage detected! Oct 06 22:34:52 volumio sudo[8819]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-06 22:33 Oct 06 22:34:52 volumio sudo[8819]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"