-- Logs begin at Sat 2025-03-08 14:15:31 MSK, end at Sat 2025-03-08 14:49:41 MSK. -- Mar 08 14:48:01 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 14:48:05 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 14:48:09 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 14:48:13 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 14:48:17 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 08 14:48:18 volumio volumio[1040]: info: CoreCommandRouter::volumioGetState Mar 08 14:48:18 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:38 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:48:38 volumio volumio[1040]: info: CURURI: music-library Mar 08 14:48:38 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:48:40 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:48:40 volumio volumio[1040]: info: CURURI: music-library/INTERNAL Mar 08 14:48:40 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:48:46 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:48:46 volumio volumio[1040]: info: CURURI: music-library Mar 08 14:48:46 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:48:47 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:48:47 volumio volumio[1040]: info: CURURI: music-library/NAS Mar 08 14:48:47 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:48:48 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:48:48 volumio volumio[1040]: info: CURURI: music-library/NAS/BB Mar 08 14:48:48 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:48:53 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:48:53 volumio volumio[1040]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::ClearQueue Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::stPlaybackTimer Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:48:53 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:53 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:53 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:48:53 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::serviceStop Mar 08 14:48:53 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:53 volumio volumio[1040]: info: CoreCommandRouter::serviceStop Mar 08 14:48:53 volumio volumio[1040]: info: ControllerMpd::stop Mar 08 14:48:53 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:48:53 volumio volumio[1040]: info: CorePlayQueue::clearPlayQueue Mar 08 14:48:53 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:48:53 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:48:53 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:48:53 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:48:53 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:48:53 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test Mar 08 14:48:53 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test in service mpd Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Rony%20Verbiest/Verbiest%20Swings%20From%20Brussels%20To%20Paris/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F01.%20Manuscript.flac&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Rony%20Verbiest/Verbiest%20Swings%20From%20Brussels%20To%20Paris/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F02.%20Blues%20For%20T.flac&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Bob%20Marley%20%26%20The%20Wailers/One%20Love/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F02.%20Bob%20Marley%20-%20Turn%20Your%20Lights%20Down%20Low.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Chemical%20Brothers/We%20Are%20The%20Night/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F03.%20Chemical%20Brothers%20-%20Das%20Spiegel.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Nick%20Cave%20And%20The%20Bad%20Seeds/The%20Boatman's%20Call/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F05.%20Nick%20Cave%20And%20The%20Bad%20Seeds%20-%20Into%20My%20Arms.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Max%20Roach/It's%20Time/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F06.%20Max%20Roach%20-%20Lonesome%20Lover.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=George%20Gershwin%3B%20Andre%20Previn%2C%20Pittsburgh%20Symphony%20Orchestra/Rhapsody%20in%20Blue/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F07.%20Gershwin%20-%20Rhapsody%20in%20Blue.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Sergei%20Prokofiev%3B%20Behzod%20Abduraimov/Shadows%20of%20my%20ancestors/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F09.%20Prokofiev%20-%20The%20Montegues%20and%20the%20Capulets.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Bjork/Homogenic/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F11.%20Bjork%20-%20Bachelorette.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:48:53 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=John%20Williams/Jurassic%20Park/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F12.%20John%20Williams%20-%20Theme%20From%20Jurassic%20Park.ape&metadata=false Mar 08 14:48:53 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:48:53 volumio volumio[1040]: info: Mar 08 14:48:53 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:53 volumio volumio[1040]: info: sendMpdCommand stop took 68 milliseconds Mar 08 14:48:53 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:53 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:53 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::play index 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::play index undefined Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand status took 9 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand stop took 1 milliseconds Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand clear took 11 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand status took 10 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand status took 10 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand status took 9 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand status took 8 milliseconds Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "NAS/BB/Test/1/01. Manuscript.flac" Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Love Is A Gift","artist":"Kentucky Thunder","album":"Good Whyskey Blues vol.9","uri":"INTERNAL/Jazz & Blues/Blues Paradise/Vol. 09/1. Kentucky Thunder - Love Is A Gift.flac","trackType":"flac"} Mar 08 14:48:54 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: No code Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:48:54 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: No code Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:48:54 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: No code Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:48:54 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: No code Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:48:54 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: No code Mar 08 14:48:54 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:54 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:54 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 129ms Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 123ms Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 122ms Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 130ms Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand add "NAS/BB/Test/1/01. Manuscript.flac" took 128 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 14ms Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 13ms Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 12ms Mar 08 14:48:54 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand play Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: Mar 08 14:48:54 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:48:54 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 31ms Mar 08 14:48:54 volumio volumio[1040]: info: sendMpdCommand play took 29 milliseconds Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 19ms Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 21ms Mar 08 14:48:54 volumio volumio[1040]: info: ------------------------------ 20ms Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 6 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 3 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 2 milliseconds Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: Mar 08 14:48:55 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 7 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 6 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 5 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 36ms Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 78ms Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 78ms Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 77ms Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 77ms Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand status took 74 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 71 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 69 milliseconds Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 70 milliseconds Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 143ms Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 139ms Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 138ms Mar 08 14:48:55 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 161 milliseconds Mar 08 14:48:55 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:48:55 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1957,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"998 Kbps","isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:48:55 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:48:55 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:48:55 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:48:55 volumio volumio[1040]: info: ------------------------------ 311ms Mar 08 14:48:55 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:48:55 volumio volumio[1040]: info: CURURI: music-library/NAS/BB/Test Mar 08 14:48:55 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:05 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:49:05 volumio volumio[1040]: info: CURURI: music-library/NAS/BB/Rony_Verbiest.zip Mar 08 14:49:05 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/1-Rony-Verbiest-Manuscript-3CM5EQ.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/2-Rony-Verbiest-Blues-for-T-NLBNKH.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/3-Rony-Verbiest-Petit-Paris-4EU6EB.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/4-Rony-Verbiest-Out-Of-Nowhere-35WWPM.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/5-Rony-Verbiest-Je-Suis-Seul-Ce-CMR4Z8.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/6-Rony-Verbiest-Mathilde-OZK41C.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/7-Rony-Verbiest-Bossa-For-Phil-DAYO7X.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/8-Rony-Verbiest-Bye-Bye-Blackbi-SAIM8P.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/9-Rony-Verbiest-Wazy-7C8SH0.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/10-Rony-Verbiest-Abigael-WOPMAP.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/11-Rony-Verbiest-La-Mer-Du-Nord-5BQ234.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/12-Rony-Verbiest-Sonny-Boy-WLM8FW.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/13-Rony-Verbiest-Amsterdamse-Gra-BMIBGK.flac Mar 08 14:49:05 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Rony_Verbiest.zip/14-Rony-Verbiest-September-Song-4U9N14.flac Mar 08 14:49:05 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/1-Rony-Verbiest-Manuscript-3CM5EQ.flac in service mpd Mar 08 14:49:05 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/1-Rony-Verbiest-Manuscript-3CM5EQ.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/2-Rony-Verbiest-Blues-for-T-NLBNKH.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/2-Rony-Verbiest-Blues-for-T-NLBNKH.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/3-Rony-Verbiest-Petit-Paris-4EU6EB.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/3-Rony-Verbiest-Petit-Paris-4EU6EB.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/4-Rony-Verbiest-Out-Of-Nowhere-35WWPM.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/4-Rony-Verbiest-Out-Of-Nowhere-35WWPM.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/5-Rony-Verbiest-Je-Suis-Seul-Ce-CMR4Z8.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/5-Rony-Verbiest-Je-Suis-Seul-Ce-CMR4Z8.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/6-Rony-Verbiest-Mathilde-OZK41C.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/6-Rony-Verbiest-Mathilde-OZK41C.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/7-Rony-Verbiest-Bossa-For-Phil-DAYO7X.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/7-Rony-Verbiest-Bossa-For-Phil-DAYO7X.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/8-Rony-Verbiest-Bye-Bye-Blackbi-SAIM8P.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/8-Rony-Verbiest-Bye-Bye-Blackbi-SAIM8P.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/9-Rony-Verbiest-Wazy-7C8SH0.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/9-Rony-Verbiest-Wazy-7C8SH0.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/10-Rony-Verbiest-Abigael-WOPMAP.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/10-Rony-Verbiest-Abigael-WOPMAP.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/11-Rony-Verbiest-La-Mer-Du-Nord-5BQ234.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/11-Rony-Verbiest-La-Mer-Du-Nord-5BQ234.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/12-Rony-Verbiest-Sonny-Boy-WLM8FW.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/12-Rony-Verbiest-Sonny-Boy-WLM8FW.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/13-Rony-Verbiest-Amsterdamse-Gra-BMIBGK.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/13-Rony-Verbiest-Amsterdamse-Gra-BMIBGK.flac' Mar 08 14:49:06 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip/14-Rony-Verbiest-September-Song-4U9N14.flac in service mpd Mar 08 14:49:06 volumio volumio[1040]: error: scanFolder - failure to stat '/mnt/NAS/BB/Rony_Verbiest.zip/14-Rony-Verbiest-September-Song-4U9N14.flac' Mar 08 14:49:09 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:49:09 volumio volumio[1040]: info: CURURI: music-library/NAS/BB/Test Mar 08 14:49:09 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:11 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 08 14:49:11 volumio volumio[1040]: info: CURURI: music-library/NAS/BB/Test/1 Mar 08 14:49:12 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:12 volumio volumio[1040]: info: Preloading song: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Bjork/Homogenic/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F11.%20Bjork%20-%20Bachelorette.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Max%20Roach/It's%20Time/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F06.%20Max%20Roach%20-%20Lonesome%20Lover.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=John%20Williams/Jurassic%20Park/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F12.%20John%20Williams%20-%20Theme%20From%20Jurassic%20Park.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Bob%20Marley%20%26%20The%20Wailers/One%20Love/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F02.%20Bob%20Marley%20-%20Turn%20Your%20Lights%20Down%20Low.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=George%20Gershwin%3B%20Andre%20Previn%2C%20Pittsburgh%20Symphony%20Orchestra/Rhapsody%20in%20Blue/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F07.%20Gershwin%20-%20Rhapsody%20in%20Blue.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Sergei%20Prokofiev%3B%20Behzod%20Abduraimov/Shadows%20of%20my%20ancestors/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F09.%20Prokofiev%20-%20The%20Montegues%20and%20the%20Capulets.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Nick%20Cave%20And%20The%20Bad%20Seeds/The%20Boatman's%20Call/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F05.%20Nick%20Cave%20And%20The%20Bad%20Seeds%20-%20Into%20My%20Arms.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/01. Manuscript.flac in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Rony%20Verbiest/Verbiest%20Swings%20From%20Brussels%20To%20Paris/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F01.%20Manuscript.flac&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/02. Blues For T.flac in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Rony%20Verbiest/Verbiest%20Swings%20From%20Brussels%20To%20Paris/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F02.%20Blues%20For%20T.flac&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:12 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape in service mpd Mar 08 14:49:12 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Chemical%20Brothers/We%20Are%20The%20Night/extralarge&path=%2Fmnt%2FNAS%2FBB%2FTest%2F1%2F03.%20Chemical%20Brothers%20-%20Das%20Spiegel.ape&metadata=false Mar 08 14:49:12 volumio volumio[1040]: info: URI /mnt/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:13 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::ClearQueue Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::stPlaybackTimer Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::serviceStop Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::serviceStop Mar 08 14:49:13 volumio volumio[1040]: info: ControllerMpd::stop Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::clearPlayQueue Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:13 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::play index 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:13 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:13 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:13 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::play index undefined Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand stop took 33 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:13 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:13 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:13 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:13 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand stop took 9 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:13 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand status took 7 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand status took 6 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand clear took 5 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand status took 2 milliseconds Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "NAS/BB/Test/1/11. Bjork - Bachelorette.ape" Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:13 volumio volumio[1040]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 14:49:13 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:13 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:13 volumio volumio[1040]: info: No code Mar 08 14:49:13 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:13 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:13 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 22ms Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 25ms Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 31ms Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand add "NAS/BB/Test/1/11. Bjork - Bachelorette.ape" took 30 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 7ms Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 5ms Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 4ms Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:13 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand play Mar 08 14:49:13 volumio volumio[1040]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 58ms Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 57ms Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: Mar 08 14:49:13 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:13 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 51ms Mar 08 14:49:13 volumio volumio[1040]: info: sendMpdCommand play took 40 milliseconds Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 32ms Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 34ms Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 35ms Mar 08 14:49:13 volumio volumio[1040]: info: ------------------------------ 34ms Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 9 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 9 milliseconds Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 17 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 16 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 13 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 5 milliseconds Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ------------------------------ 37ms Mar 08 14:49:14 volumio volumio[1040]: info: ------------------------------ 61ms Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: Mar 08 14:49:14 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 58 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 60 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 62 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 61 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 19 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand status took 18 milliseconds Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ------------------------------ 289ms Mar 08 14:49:14 volumio volumio[1040]: info: ------------------------------ 286ms Mar 08 14:49:14 volumio volumio[1040]: info: ------------------------------ 288ms Mar 08 14:49:14 volumio volumio[1040]: info: ------------------------------ 287ms Mar 08 14:49:14 volumio volumio[1040]: info: ------------------------------ 277ms Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 234 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 231 milliseconds Mar 08 14:49:14 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 232 milliseconds Mar 08 14:49:14 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bachelorette","artist":"Bjork","album":"Homogenic","uri":"NAS/BB/Test/1/11. Bjork - Bachelorette.ape","trackType":"ape"} Mar 08 14:49:14 volumio volumio[1040]: verbose: CURRENT POSITION 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:14 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:14 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:14 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:14 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:15 volumio volumio[1040]: info: ------------------------------ 401ms Mar 08 14:49:15 volumio volumio[1040]: info: ------------------------------ 356ms Mar 08 14:49:15 volumio volumio[1040]: info: ------------------------------ 358ms Mar 08 14:49:20 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::ClearQueue Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::stPlaybackTimer Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::serviceStop Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::serviceStop Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::stop Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::clearPlayQueue Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:20 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::play index 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:20 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:20 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:20 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::play index undefined Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand stop took 40 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand stop took 17 milliseconds Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand status took 5 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand clear took 5 milliseconds Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "NAS/BB/Test/1/02. Blues For T.flac" Mar 08 14:49:20 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand status took 40 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand status took 40 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand status took 39 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand status took 38 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 38ms Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand add "NAS/BB/Test/1/02. Blues For T.flac" took 12 milliseconds Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:20 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand play Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:20 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: No code Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:20 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: No code Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:20 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: No code Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:20 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: info: No code Mar 08 14:49:20 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:20 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:20 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:20 volumio volumio[1040]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 146ms Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 145ms Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 145ms Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 146ms Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 150ms Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 119ms Mar 08 14:49:20 volumio volumio[1040]: info: sendMpdCommand play took 111 milliseconds Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 5ms Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 4ms Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: Mar 08 14:49:20 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:20 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 22ms Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 21ms Mar 08 14:49:20 volumio volumio[1040]: info: ------------------------------ 20ms Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:23 volumio volumio[1040]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::ClearQueue Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::clearPlayQueue Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:23 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:23 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:23 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:23 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::play index 7 Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:23 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:23 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:23 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:23 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::play index undefined Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 32 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 31 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 30 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 29 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 30 milliseconds Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: Mar 08 14:49:23 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand stop took 20 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 19 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 21 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 21 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 20 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 20 milliseconds Mar 08 14:49:23 volumio volumio[1040]: info: sendMpdCommand status took 19 milliseconds Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:23 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:23 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:23 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:23 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:23 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3346,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:23 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:23 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3346,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3346,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3346,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3346,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"761 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 83ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 119ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 118ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 118ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 117ms Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 77 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand clear took 70 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 70 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 66 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 65 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 7 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 5 milliseconds Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "NAS/BB/Test/1/01. Manuscript.flac" Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 14:49:24 volumio volumio[1040]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::play index undefined Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 145ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 142ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 141ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 140ms Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 157ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 159ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 159ms Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 207ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 204 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand add "NAS/BB/Test/1/01. Manuscript.flac" took 204 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand stop took 57 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 38ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 37ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 36ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 35ms Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand play Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 14:49:24 volumio volumio[1040]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 292ms Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 14ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand play took 11 milliseconds Mar 08 14:49:24 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:24 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:24 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand clear took 318 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 315ms Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 314ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 314ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 314ms Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "NAS/BB/Test/1/02. Blues For T.flac" Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 14ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 12 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand add "NAS/BB/Test/1/02. Blues For T.flac" took 11 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 11ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 10 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 10ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 9 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 7ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 7 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 7ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 7 milliseconds Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand play Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: No code Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 175ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 174ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 175ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 173ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 173ms Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:24 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 179ms Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand play took 175 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 8ms Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 10ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 9ms Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: Mar 08 14:49:24 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 36 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 34 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 32 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 32 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 29 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand status took 27 milliseconds Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 14:49:24 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"922 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"922 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"922 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"922 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"922 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1092,"duration":188,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"922 Kbps","isStreaming":false,"title":"Blues for T","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/02. Blues For T.flac","trackType":"flac"} Mar 08 14:49:24 volumio volumio[1040]: verbose: CURRENT POSITION 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:24 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:24 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:24 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 87ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 172ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 169ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 168ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 167ms Mar 08 14:49:24 volumio volumio[1040]: info: ------------------------------ 165ms Mar 08 14:49:30 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::ClearQueue Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::stPlaybackTimer Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::serviceStop Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 8 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::serviceStop Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::stop Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::clearPlayQueue Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:30 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/11. Bjork - Bachelorette.ape Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/06. Max Roach - Lonesome Lover.ape Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/12. John Williams - Theme From Jurassic Park.ape Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Bob Marley - Turn Your Lights Down Low.ape Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/07. Gershwin - Rhapsody in Blue.ape Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/09. Prokofiev - The Montegues and the Capulets.ape Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/05. Nick Cave And The Bad Seeds - Into My Arms.ape Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::play index 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:30 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/02. Blues For T.flac Mar 08 14:49:30 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:30 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test/1/03. Chemical Brothers - Das Spiegel.ape Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::play index undefined Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks NAS/BB/Test/1/01. Manuscript.flac Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand stop took 32 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand stop took 4 milliseconds Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand clear Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 5 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand clear took 4 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 3 milliseconds Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand add "NAS/BB/Test/1/01. Manuscript.flac" Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: No code Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 45ms Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: error: updateQueue error: null Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 50 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 49 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 49 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 49ms Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 48 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand add "NAS/BB/Test/1/01. Manuscript.flac" took 48 milliseconds Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand play Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: No code Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: No code Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: No code Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 163ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 163ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 164ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 170ms Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 151ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 146ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 144ms Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand play took 142 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 27ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 27ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 15ms Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces system playlist update Mar 08 14:49:30 volumio volumio[1040]: info: Ignoring MPD Status Update Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 8ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 3ms Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 6 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 2 milliseconds Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: Mar 08 14:49:30 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::getState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand status Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 9 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 5 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 4 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand status took 3 milliseconds Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseState Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus stop Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 46ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 110ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 109ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 107ms Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 100 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 100 milliseconds Mar 08 14:49:30 volumio volumio[1040]: info: sendMpdCommand playlistinfo took 100 milliseconds Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: verbose: ControllerMpd::parseTrackInfo Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ControllerMpd::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::servicePushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Manuscript","artist":"Rony Verbiest","album":"Verbiest Swings From Brussels To Paris","uri":"NAS/BB/Test/1/01. Manuscript.flac","trackType":"flac"} Mar 08 14:49:30 volumio volumio[1040]: verbose: CURRENT POSITION 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState stateService play Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::syncState currentStatus play Mar 08 14:49:30 volumio volumio[1040]: info: Received an update from plugin. extracting info from payload Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:30 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:30 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 214ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 209ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 209ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 208ms Mar 08 14:49:30 volumio volumio[1040]: info: ------------------------------ 208ms Mar 08 14:49:40 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:40 volumio volumio[1040]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::ClearQueue Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::stPlaybackTimer Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::pushState Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:40 volumio volumio[1040]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 08 14:49:40 volumio volumio[1040]: info: CoreCommandRouter::volumioPushState Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::serviceStop Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::getTrack 7 Mar 08 14:49:40 volumio volumio[1040]: info: CoreCommandRouter::serviceStop Mar 08 14:49:40 volumio volumio[1040]: info: ControllerMpd::stop Mar 08 14:49:40 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::clearPlayQueue Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:40 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:40 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:40 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/О чем говорят мужчины.mp4 Mar 08 14:49:40 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/О чем говорят мужчины.mp4 Mar 08 14:49:40 volumio volumio[1040]: info: CoreCommandRouter::volumioPushQueue Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::saveQueue Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::updateTrackBlock Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::getTrackBlock Mar 08 14:49:40 volumio volumio[1040]: info: CoreCommandRouter::volumioPlay Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::play index 0 Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::addQueueItems Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::addQueueItems Mar 08 14:49:40 volumio volumio[1040]: info: Preload queue cleared Mar 08 14:49:40 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Rony_Verbiest.zip Mar 08 14:49:40 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Rony_Verbiest.zip in service mpd Mar 08 14:49:40 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Test Mar 08 14:49:40 volumio volumio[1040]: info: Using cached record of: music-library/NAS/BB/Test Mar 08 14:49:40 volumio volumio[1040]: info: Adding Item to queue: music-library/NAS/BB/Саундтрек Ах водевиль водевиль Mar 08 14:49:40 volumio volumio[1040]: info: Exploding uri music-library/NAS/BB/Саундтрек Ах водевиль водевиль in service mpd Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::stop Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::play index undefined Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:40 volumio volumio[1040]: info: CoreStateMachine::startPlaybackTimer Mar 08 14:49:40 volumio volumio[1040]: info: CorePlayQueue::getTrack 0 Mar 08 14:49:40 volumio volumio[1040]: verbose: ControllerMpd::clearAddPlayTracks NAS/BB/О чем говорят мужчины.mp4 Mar 08 14:49:40 volumio volumio[1040]: verbose: ControllerMpd::sendMpdCommand stop Mar 08 14:49:40 volumio volumio[1040]: info: Mar 08 14:49:40 volumio volumio[1040]: ---------------------------- MPD announces state update: player Mar 08 14:49:40 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Rony%20Verbiest/Verbiest%20Swings%20From%20Brussels%20To%20Paris/extralarge&path=%2Fmnt%2FNAS%2FBB%2FRony_Verbiest.zip&metadata=false Mar 08 14:49:40 volumio volumio[1040]: info: URI /mnt/NAS/BB/Rony_Verbiest.zip Mar 08 14:49:40 volumio volumio[1040]: info: ALBUMART /albumart?cacheid=257&web=Rony%20Verbiest/Verbiest%20Swings%20From%20Brussels%20To%20Paris/extralarge&path=%2Fmnt%2FNAS%2FBB%2FRony_Verbiest.zip&metadata=false Mar 08 14:49:40 volumio volumio[1040]: info: URI /mnt/NAS/BB/Rony_Verbiest.zip Mar 08 14:49:40 volumio volumio[1040]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 14:49:40 volumio volumio[1040]: Error: Unable to resolve or reject the same promise twice Mar 08 14:49:40 volumio volumio[1040]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 08 14:49:40 volumio volumio[1040]: at /volumio/app/plugins/music_service/mpd/index.js:2569:21 Mar 08 14:49:40 volumio volumio[1040]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 08 14:49:40 volumio volumio[1040]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 08 14:49:40 volumio volumio[1040]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 08 14:49:40 volumio volumio[1040]: at Socket.emit (events.js:400:28) Mar 08 14:49:40 volumio volumio[1040]: at addChunk (internal/streams/readable.js:293:12) Mar 08 14:49:40 volumio volumio[1040]: at readableAddChunk (internal/streams/readable.js:263:11) Mar 08 14:49:40 volumio volumio[1040]: at Socket.Readable.push (internal/streams/readable.js:206:10) Mar 08 14:49:40 volumio volumio[1040]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Mar 08 14:49:40 volumio volumio[1040]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 08 14:49:41 volumio sudo[6920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-08 14:48 Mar 08 14:49:41 volumio sudo[6920]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:15:38 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9e0e048b157c8fb0f19240808f3da58b"