-- Logs begin at Thu 2019-02-14 12:11:59 EET, end at Fri 2024-05-03 16:47:29 EEST. -- May 03 16:46:01 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 16:46:01 volumio volumio[833]: info: CURURI: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81) May 03 16:46:01 volumio volumio[833]: info: Preload queue cleared May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A3 Dangerous Rhythm.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A4 Losing Control.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A5 Dance Till You Get Enough.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B1 Friends.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B2 I Gotta Have You Back.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B3 High Dimension.dsf May 03 16:46:01 volumio volumio[833]: info: Preloading song: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B4 Fever Line.dsf May 03 16:46:01 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf in service mpd May 03 16:46:01 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FA1%20That%20Loving%20Feeling.dsf&metadata=false May 03 16:46:01 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf May 03 16:46:01 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf in service mpd May 03 16:46:01 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FA2%20Try%20Love.dsf&metadata=false May 03 16:46:01 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf May 03 16:46:01 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A3 Dangerous Rhythm.dsf in service mpd May 03 16:46:01 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FA3%20Dangerous%20Rhythm.dsf&metadata=false May 03 16:46:01 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A3 Dangerous Rhythm.dsf May 03 16:46:01 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A4 Losing Control.dsf in service mpd May 03 16:46:01 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FA4%20Losing%20Control.dsf&metadata=false May 03 16:46:01 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A4 Losing Control.dsf May 03 16:46:01 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A5 Dance Till You Get Enough.dsf in service mpd May 03 16:46:01 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FA5%20Dance%20Till%20You%20Get%20Enough.dsf&metadata=false May 03 16:46:01 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A5 Dance Till You Get Enough.dsf May 03 16:46:01 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B1 Friends.dsf in service mpd May 03 16:46:01 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FB1%20Friends.dsf&metadata=false May 03 16:46:01 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B1 Friends.dsf May 03 16:46:02 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B2 I Gotta Have You Back.dsf in service mpd May 03 16:46:02 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FB2%20I%20Gotta%20Have%20You%20Back.dsf&metadata=false May 03 16:46:02 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B2 I Gotta Have You Back.dsf May 03 16:46:02 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B3 High Dimension.dsf in service mpd May 03 16:46:02 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FB3%20High%20Dimension.dsf&metadata=false May 03 16:46:02 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B3 High Dimension.dsf May 03 16:46:02 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B4 Fever Line.dsf in service mpd May 03 16:46:02 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Amii%20Stewart/Try%20Love%2C(CA2ML%2BNG-6%2B308%2BTT-81)/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAmii%20Stewart%20-%20Try%20Love%20-%201985%2C(Germany)%2CDSF(tracks)%2C(CA2ML%2BNG-6%2B308%2BTT-81)%2FB4%20Fever%20Line.dsf&metadata=false May 03 16:46:02 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B4 Fever Line.dsf May 03 16:46:03 volumio volumio[833]: info: Preload queue cleared May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::stPlaybackTimer May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 11 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::serviceStop May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 11 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::serviceStop May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::stop May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:46:03 volumio volumio[833]: info: Preload queue cleared May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A3 Dangerous Rhythm.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A3 Dangerous Rhythm.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A4 Losing Control.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A4 Losing Control.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A5 Dance Till You Get Enough.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A5 Dance Till You Get Enough.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B1 Friends.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B1 Friends.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B2 I Gotta Have You Back.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B2 I Gotta Have You Back.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B3 High Dimension.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B3 High Dimension.dsf May 03 16:46:03 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B4 Fever Line.dsf May 03 16:46:03 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/B4 Fever Line.dsf May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPlay May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::play index 0 May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand stop took 16 milliseconds May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand stop took 4 milliseconds May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:03 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 30 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand clear took 30 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 28 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 27 milliseconds May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf" May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: 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} May 03 16:46:03 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: No code May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: 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} May 03 16:46:03 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: No code May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 56ms May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 55ms May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:03 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:03 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:03 volumio volumio[833]: error: updateQueue error: null May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:03 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 35ms May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand playlistinfo took 34 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand add "NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf" took 34 milliseconds May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 5ms May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 4ms May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand play May 03 16:46:03 volumio volumio[833]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 68ms May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:03 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:03 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:03 volumio volumio[833]: info: touch_display: Setting screensaver timeout to 9007199254740991 seconds. May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 12ms May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand play took 10 milliseconds May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 8ms May 03 16:46:03 volumio volumio[833]: info: ------------------------------ 7ms May 03 16:46:03 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 13 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 12 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 11 milliseconds May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: May 03 16:46:03 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 31 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand playlistinfo took 29 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand playlistinfo took 29 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand playlistinfo took 29 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 27 milliseconds May 03 16:46:03 volumio volumio[833]: info: sendMpdCommand status took 26 milliseconds May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:03 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":720,"duration":299,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1 That Loving Feeling","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf","trackType":"dsf"} May 03 16:46:03 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":720,"duration":299,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1 That Loving Feeling","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf","trackType":"dsf"} May 03 16:46:03 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:03 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:03 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:03 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:03 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":720,"duration":299,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1 That Loving Feeling","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf","trackType":"dsf"} May 03 16:46:03 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:03 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:03 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:03 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: ------------------------------ 60ms May 03 16:46:04 volumio volumio[833]: info: ------------------------------ 65ms May 03 16:46:04 volumio volumio[833]: info: ------------------------------ 64ms May 03 16:46:04 volumio volumio[833]: info: sendMpdCommand playlistinfo took 26 milliseconds May 03 16:46:04 volumio volumio[833]: info: sendMpdCommand playlistinfo took 26 milliseconds May 03 16:46:04 volumio volumio[833]: info: sendMpdCommand playlistinfo took 25 milliseconds May 03 16:46:04 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:04 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:04 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:04 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":763,"duration":299,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1 That Loving Feeling","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf","trackType":"dsf"} May 03 16:46:04 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:04 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":763,"duration":299,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1 That Loving Feeling","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf","trackType":"dsf"} May 03 16:46:04 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:04 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":763,"duration":299,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"11289 Kbps","isStreaming":false,"title":"A1 That Loving Feeling","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf","trackType":"dsf"} May 03 16:46:04 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:04 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:04 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:04 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:04 volumio volumio[833]: info: ------------------------------ 82ms May 03 16:46:04 volumio volumio[833]: info: ------------------------------ 78ms May 03 16:46:04 volumio volumio[833]: info: ------------------------------ 78ms May 03 16:46:04 volumio volumio[833]: info: touch_display: Setting screensaver timeout to 0 seconds. May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioNext May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::next May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::stPlaybackTimer May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::serviceStop May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::serviceStop May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::stop May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand stop took 26 milliseconds May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 12 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand stop took 10 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 6 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 4 milliseconds May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:21 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 4 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand clear took 4 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 4 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 4 milliseconds May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf" May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: 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":"A1 That Loving Feeling","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A1 That Loving Feeling.dsf","trackType":"dsf"} May 03 16:46:21 volumio volumio[833]: verbose: CURRENT POSITION 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: No code May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 03 16:46:21 volumio volumio[833]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 46ms May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 39ms May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 38ms May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:21 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:21 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:21 volumio volumio[833]: info: touch_display: Setting screensaver timeout to 9007199254740991 seconds. May 03 16:46:21 volumio volumio[833]: error: updateQueue error: null May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:21 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 34ms May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand add "NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf" took 31 milliseconds May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 7ms May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 7ms May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand play May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:21 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:21 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 26ms May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand play took 19 milliseconds May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 18ms May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 16ms May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 15 milliseconds May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 19 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 18 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 5 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 5 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 3 milliseconds May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A2 Try Love","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf","trackType":"dsf"} May 03 16:46:21 volumio volumio[833]: verbose: CURRENT POSITION 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 30ms May 03 16:46:21 volumio volumio[833]: info: May 03 16:46:21 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 9 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 10 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 10 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 10 milliseconds May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand status took 5 milliseconds May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A2 Try Love","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf","trackType":"dsf"} May 03 16:46:21 volumio volumio[833]: verbose: CURRENT POSITION 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:21 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A2 Try Love","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf","trackType":"dsf"} May 03 16:46:21 volumio volumio[833]: verbose: CURRENT POSITION 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:21 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A2 Try Love","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf","trackType":"dsf"} May 03 16:46:21 volumio volumio[833]: verbose: CURRENT POSITION 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:21 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A2 Try Love","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf","trackType":"dsf"} May 03 16:46:21 volumio volumio[833]: verbose: CURRENT POSITION 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:21 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 87ms May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 86ms May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 75ms May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 73ms May 03 16:46:21 volumio volumio[833]: info: sendMpdCommand playlistinfo took 52 milliseconds May 03 16:46:21 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:21 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"A2 Try Love","artist":"Amii Stewart","album":"Try Love,(CA2ML+NG-6+308+TT-81)","uri":"NAS/NAS/DSD/Amii Stewart - Try Love - 1985,(Germany),DSF(tracks),(CA2ML+NG-6+308+TT-81)/A2 Try Love.dsf","trackType":"dsf"} May 03 16:46:21 volumio volumio[833]: verbose: CURRENT POSITION 1 May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:46:21 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:21 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:21 volumio volumio[833]: info: ------------------------------ 73ms May 03 16:46:21 volumio volumio[833]: info: touch_display: Setting screensaver timeout to 0 seconds. May 03 16:46:31 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 03 16:46:31 volumio volumio[833]: info: CURURI: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971) May 03 16:46:31 volumio volumio[833]: info: Preload queue cleared May 03 16:46:37 volumio volumio[833]: info: Preload queue cleared May 03 16:46:37 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::stPlaybackTimer May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:46:37 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:37 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:37 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:37 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::serviceStop May 03 16:46:37 volumio volumio[833]: info: CorePlayQueue::getTrack 1 May 03 16:46:37 volumio volumio[833]: info: CoreCommandRouter::serviceStop May 03 16:46:37 volumio volumio[833]: info: ControllerMpd::stop May 03 16:46:37 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:46:37 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:46:37 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:46:37 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:46:37 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:46:37 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:46:37 volumio volumio[833]: info: Preload queue cleared May 03 16:46:37 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:46:37 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue in service mpd May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPlay May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::play index 0 May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:46:38 volumio volumio[833]: info: May 03 16:46:38 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:38 volumio volumio[833]: info: sendMpdCommand stop took 251 milliseconds May 03 16:46:38 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:38 volumio volumio[833]: info: sendMpdCommand stop took 31 milliseconds May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:46:38 volumio volumio[833]: info: May 03 16:46:38 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:38 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:38 volumio volumio[833]: info: May 03 16:46:38 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:46:38 volumio volumio[833]: info: ControllerMpd::getState May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:46:38 volumio volumio[833]: info: May 03 16:46:38 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:38 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:38 volumio volumio[833]: info: sendMpdCommand status took 8 milliseconds May 03 16:46:38 volumio volumio[833]: info: sendMpdCommand clear took 7 milliseconds May 03 16:46:38 volumio volumio[833]: info: sendMpdCommand status took 5 milliseconds May 03 16:46:38 volumio volumio[833]: info: sendMpdCommand status took 4 milliseconds May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue" May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:46:38 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: 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} May 03 16:46:38 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:38 volumio volumio[833]: info: No code May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:38 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: 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} May 03 16:46:38 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:38 volumio volumio[833]: info: No code May 03 16:46:38 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:46:38 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:38 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:46:38 volumio volumio[833]: info: ------------------------------ 30ms May 03 16:46:38 volumio volumio[833]: info: ------------------------------ 29ms May 03 16:46:38 volumio volumio[833]: info: May 03 16:46:38 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:38 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:38 volumio volumio[833]: info: May 03 16:46:38 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:38 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:38 volumio volumio[833]: error: updateQueue error: null May 03 16:46:38 volumio volumio[833]: info: ------------------------------ 33ms May 03 16:46:38 volumio volumio[833]: info: sendMpdCommand playlistinfo took 33 milliseconds May 03 16:46:38 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:46:38 volumio volumio[833]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined May 03 16:46:38 volumio volumio[833]: info: ------------------------------ 44ms May 03 16:46:38 volumio volumio[833]: info: touch_display: Setting screensaver timeout to 9007199254740991 seconds. May 03 16:46:38 volumio volumio[833]: error: updateQueue error: null May 03 16:46:38 volumio volumio[833]: error: updateQueue error: null May 03 16:46:38 volumio volumio[833]: info: ------------------------------ 590ms May 03 16:46:47 volumio volumio[833]: info: Preload queue cleared May 03 16:46:47 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:47 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:46:47 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:46:47 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:46:47 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:46:47 volumio volumio[833]: info: Preload queue cleared May 03 16:46:47 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:46:47 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:46:47 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:46:47 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:46:47 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:46:47 volumio volumio[833]: info: CoreCommandRouter::volumioPlay May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::play index 0 May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:46:47 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:47 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:46:47 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:46:47 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:46:47 volumio volumio[833]: info: sendMpdCommand stop took 1 milliseconds May 03 16:46:47 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:46:47 volumio volumio[833]: info: May 03 16:46:47 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:47 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:47 volumio volumio[833]: info: sendMpdCommand clear took 1 milliseconds May 03 16:46:47 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue" May 03 16:46:47 volumio volumio[833]: info: May 03 16:46:47 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:47 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:47 volumio volumio[833]: info: May 03 16:46:47 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:46:47 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:46:47 volumio volumio[833]: error: updateQueue error: null May 03 16:46:47 volumio volumio[833]: error: updateQueue error: null May 03 16:46:47 volumio volumio[833]: error: updateQueue error: null May 03 16:46:47 volumio volumio[833]: info: ------------------------------ 4ms May 03 16:46:47 volumio volumio[833]: info: ------------------------------ 2ms May 03 16:46:47 volumio volumio[833]: info: ------------------------------ 1ms May 03 16:47:01 volumio volumio[833]: info: Preload queue cleared May 03 16:47:01 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:01 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:47:01 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:47:01 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:47:01 volumio volumio[833]: info: Preload queue cleared May 03 16:47:01 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:01 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:01 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:47:01 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:47:01 volumio volumio[833]: info: CoreCommandRouter::volumioPlay May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::play index 0 May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:01 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:47:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:47:01 volumio volumio[833]: info: sendMpdCommand stop took 1 milliseconds May 03 16:47:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:47:01 volumio volumio[833]: info: May 03 16:47:01 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:01 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:01 volumio volumio[833]: info: sendMpdCommand clear took 2 milliseconds May 03 16:47:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue" May 03 16:47:01 volumio volumio[833]: info: May 03 16:47:01 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:01 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:01 volumio volumio[833]: info: May 03 16:47:01 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:01 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:01 volumio volumio[833]: error: updateQueue error: null May 03 16:47:01 volumio volumio[833]: error: updateQueue error: null May 03 16:47:01 volumio volumio[833]: error: updateQueue error: null May 03 16:47:01 volumio volumio[833]: info: ------------------------------ 4ms May 03 16:47:01 volumio volumio[833]: info: ------------------------------ 2ms May 03 16:47:01 volumio volumio[833]: info: ------------------------------ 1ms May 03 16:47:02 volumio volumio[833]: info: Preload queue cleared May 03 16:47:02 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:02 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:47:02 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:02 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:47:02 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:47:02 volumio volumio[833]: info: Preload queue cleared May 03 16:47:02 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:02 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:02 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:02 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:47:02 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:47:02 volumio volumio[833]: info: CoreCommandRouter::volumioPlay May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::play index 0 May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:02 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:02 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:47:02 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:02 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:47:02 volumio volumio[833]: info: sendMpdCommand stop took 2 milliseconds May 03 16:47:02 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:47:02 volumio volumio[833]: info: May 03 16:47:02 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:02 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:02 volumio volumio[833]: info: sendMpdCommand clear took 2 milliseconds May 03 16:47:02 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue" May 03 16:47:02 volumio volumio[833]: info: May 03 16:47:02 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:02 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:02 volumio volumio[833]: info: May 03 16:47:02 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:02 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:02 volumio volumio[833]: error: updateQueue error: null May 03 16:47:02 volumio volumio[833]: error: updateQueue error: null May 03 16:47:02 volumio volumio[833]: error: updateQueue error: null May 03 16:47:02 volumio volumio[833]: info: ------------------------------ 3ms May 03 16:47:02 volumio volumio[833]: info: ------------------------------ 1ms May 03 16:47:02 volumio volumio[833]: info: ------------------------------ 2ms May 03 16:47:05 volumio volumio[833]: info: Preload queue cleared May 03 16:47:05 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:05 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:47:05 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:05 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:47:05 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:47:05 volumio volumio[833]: info: Preload queue cleared May 03 16:47:05 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:05 volumio volumio[833]: info: Using cached record of: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:05 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:05 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:47:05 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:47:05 volumio volumio[833]: info: CoreCommandRouter::volumioPlay May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::play index 0 May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:05 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:05 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:47:05 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:05 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:47:05 volumio volumio[833]: info: sendMpdCommand stop took 2 milliseconds May 03 16:47:05 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:47:05 volumio volumio[833]: info: May 03 16:47:05 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:05 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:05 volumio volumio[833]: info: sendMpdCommand clear took 2 milliseconds May 03 16:47:05 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand load "NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue" May 03 16:47:05 volumio volumio[833]: info: May 03 16:47:05 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:05 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:05 volumio volumio[833]: info: May 03 16:47:05 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:05 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:05 volumio volumio[833]: error: updateQueue error: null May 03 16:47:05 volumio volumio[833]: error: updateQueue error: null May 03 16:47:05 volumio volumio[833]: error: updateQueue error: null May 03 16:47:05 volumio volumio[833]: info: ------------------------------ 4ms May 03 16:47:05 volumio volumio[833]: info: ------------------------------ 2ms May 03 16:47:21 volumio volumio[833]: info: Preload queue cleared May 03 16:47:21 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:47:21 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:47:21 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:21 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:21 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:47:21 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:21 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:21 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:47:21 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:47:21 volumio volumio[833]: info: Preload queue cleared May 03 16:47:25 volumio kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 May 03 16:47:25 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD May 03 16:47:25 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD in service mpd May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FA1.%20Baddest%20Blues.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FA2.%20Bang%20Bang%20Boom%20Boom.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A2. Bang Bang Boom Boom.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FA3.%20Better%20Man.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A3. Better Man.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FA4.%20Caught%20Out%20In%20The%20Rain.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A4. Caught Out In The Rain.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FA5.%20Swing%20My%20Thing%20Back%20Around.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A5. Swing My Thing Back Around.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FA6.%20With%20You%20Everyday.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A6. With You Everyday.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FB1.%20Thru%20The%20Window%20Of%20My%20Mind.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/B1. Thru The Window Of My Mind.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FB2.%20Spirit%20Of%20God.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/B2. Spirit Of God.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FB3.%20There%20In%20Your%20Heart.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/B3. There In Your Heart.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FB4.%20The%20Ugliest%20House%20On%20The%20Block.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/B4. The Ugliest House On The Block.dsf May 03 16:47:25 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=Beth%20Hart/Bang%20Bang%20Boom%20Boom/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FBeth%20Hart%20%5B2012%5D%20Bang%20Bang%20Boom%20Boom%20(PRD%207393%201%2C%20EU)%20DSD%2FB5.%20Everything%20Must%20Change.dsf&metadata=false May 03 16:47:25 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/B5. Everything Must Change.dsf May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPlay May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::play index 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::play index undefined May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand stop took 1 milliseconds May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:25 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand clear took 1 milliseconds May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf" May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:25 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:25 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:25 volumio volumio[833]: error: updateQueue error: null May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:25 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 7ms May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand add "NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf" took 7 milliseconds May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 5ms May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 4ms May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand play May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:25 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces system playlist update May 03 16:47:25 volumio volumio[833]: info: Ignoring MPD Status Update May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 7ms May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand play took 4 milliseconds May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 3ms May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 2ms May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::getState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::getState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::getState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand status took 15 milliseconds May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::getState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand status took 17 milliseconds May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand status took 16 milliseconds May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand playlistinfo took 3 milliseconds May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baddest Blues","artist":"Beth Hart","album":"Bang Bang Boom Boom","uri":"NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf","trackType":"dsf"} May 03 16:47:25 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 21ms May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::getState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:47:25 volumio volumio[833]: info: May 03 16:47:25 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::getState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand status took 5 milliseconds May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand playlistinfo took 5 milliseconds May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand playlistinfo took 4 milliseconds May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand status took 3 milliseconds May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand status took 2 milliseconds May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseState May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baddest Blues","artist":"Beth Hart","album":"Bang Bang Boom Boom","uri":"NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf","trackType":"dsf"} May 03 16:47:25 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:47:25 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baddest Blues","artist":"Beth Hart","album":"Bang Bang Boom Boom","uri":"NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf","trackType":"dsf"} May 03 16:47:25 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:47:25 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 37ms May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand playlistinfo took 15 milliseconds May 03 16:47:25 volumio volumio[833]: info: sendMpdCommand playlistinfo took 18 milliseconds May 03 16:47:25 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baddest Blues","artist":"Beth Hart","album":"Bang Bang Boom Boom","uri":"NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf","trackType":"dsf"} May 03 16:47:25 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:47:25 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baddest Blues","artist":"Beth Hart","album":"Bang Bang Boom Boom","uri":"NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf","trackType":"dsf"} May 03 16:47:25 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:47:25 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: ControllerMpd::pushState May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":286,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Baddest Blues","artist":"Beth Hart","album":"Bang Bang Boom Boom","uri":"NAS/NAS/DSD/Beth Hart [2012] Bang Bang Boom Boom (PRD 7393 1, EU) DSD/A1. Baddest Blues.dsf","trackType":"dsf"} May 03 16:47:25 volumio volumio[833]: verbose: CURRENT POSITION 0 May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play May 03 16:47:25 volumio volumio[833]: info: Received an update from plugin. extracting info from payload May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 45ms May 03 16:47:25 volumio volumio[833]: info: ------------------------------ 43ms May 03 16:47:25 volumio volumio[833]: info: touch_display: Setting screensaver timeout to 0 seconds. May 03 16:47:26 volumio volumio[833]: info: Preload queue cleared May 03 16:47:26 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::ClearQueue May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::stop May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::stPlaybackTimer May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock May 03 16:47:26 volumio volumio[833]: info: CorePlayQueue::getTrackBlock May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::pushState May 03 16:47:26 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:26 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 03 16:47:26 volumio volumio[833]: info: CoreCommandRouter::volumioPushState May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::serviceStop May 03 16:47:26 volumio volumio[833]: info: CorePlayQueue::getTrack 0 May 03 16:47:26 volumio volumio[833]: info: CoreCommandRouter::serviceStop May 03 16:47:26 volumio volumio[833]: info: ControllerMpd::stop May 03 16:47:26 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop May 03 16:47:26 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue May 03 16:47:26 volumio volumio[833]: info: CorePlayQueue::saveQueue May 03 16:47:26 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue May 03 16:47:26 volumio volumio[833]: info: CoreStateMachine::addQueueItems May 03 16:47:26 volumio volumio[833]: info: CorePlayQueue::addQueueItems May 03 16:47:26 volumio volumio[833]: info: Preload queue cleared May 03 16:47:26 volumio volumio[833]: info: Adding Item to queue: music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971) May 03 16:47:26 volumio volumio[833]: info: Exploding uri music-library/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971) in service mpd May 03 16:47:26 volumio volumio[833]: info: May 03 16:47:26 volumio volumio[833]: ---------------------------- MPD announces state update: player May 03 16:47:26 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=/Live%20At%20Fillmore%20West/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAretha%20Franklin%20%E2%80%93%20Live%20At%20Fillmore%20West%20-%20(1971)%2FAretha%20Franklin%20%E2%80%93%20Live%20At%20Fillmore%20West.cue&metadata=false May 03 16:47:26 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:26 volumio volumio[833]: info: ALBUMART /albumart?cacheid=771&web=/Live%20At%20Fillmore%20West/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FDSD%2FAretha%20Franklin%20%E2%80%93%20Live%20At%20Fillmore%20West%20-%20(1971)%2FAretha%20Franklin%20%E2%80%93%20Live%20At%20Fillmore%20West.cue&metadata=false May 03 16:47:26 volumio volumio[833]: info: URI /mnt/NAS/NAS/DSD/Aretha Franklin – Live At Fillmore West - (1971)/Aretha Franklin – Live At Fillmore West.cue May 03 16:47:26 volumio volumio[833]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 16:47:26 volumio volumio[833]: Error: Unable to resolve or reject the same promise twice May 03 16:47:26 volumio volumio[833]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) May 03 16:47:26 volumio volumio[833]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 May 03 16:47:26 volumio volumio[833]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) May 03 16:47:26 volumio volumio[833]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) May 03 16:47:26 volumio volumio[833]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) May 03 16:47:26 volumio volumio[833]: at Socket.emit (events.js:315:20) May 03 16:47:26 volumio volumio[833]: at addChunk (internal/streams/readable.js:309:12) May 03 16:47:26 volumio volumio[833]: at readableAddChunk (internal/streams/readable.js:280:11) May 03 16:47:26 volumio volumio[833]: at Socket.Readable.push (internal/streams/readable.js:223:10) May 03 16:47:26 volumio volumio[833]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) May 03 16:47:26 volumio volumio[833]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 16:47:29 volumio sudo[21032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 16:46 May 03 16:47:29 volumio sudo[21032]: 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="56d8f4e08ca3cb143324aa0740c362c469043a9b" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="a77c7968e70cebb21b39a3791120006fed600769" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 31 Mar 2024 12:34:13 PM CEST" VOLUMIO_VERSION="3.637" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="41a89107ca82d89cff75a3106ff77fdf"