-- Logs begin at Mon 2024-08-19 11:49:45 UTC, end at Thu 2024-08-22 12:52:47 UTC. -- Aug 22 12:51:45 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 22 12:51:45 volumio volumio[1017]: info: CURURI: music-library Aug 22 12:51:46 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 22 12:51:46 volumio volumio[1017]: info: CURURI: music-library/USB Aug 22 12:51:47 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 22 12:51:47 volumio volumio[1017]: info: CURURI: music-library/USB/My Passport Aug 22 12:51:48 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 22 12:51:48 volumio volumio[1017]: info: CURURI: music-library/USB/My Passport/AIFF 2.6T Aug 22 12:51:50 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 22 12:51:50 volumio volumio[1017]: info: CURURI: music-library/USB/My Passport/AIFF 2.6T/3.Pop Aug 22 12:51:54 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 22 12:51:54 volumio volumio[1017]: info: CURURI: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele Aug 22 12:51:57 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Aug 22 12:51:57 volumio volumio[1017]: info: CURURI: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19 Aug 22 12:51:59 volumio volumio[1017]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 22 12:51:59 volumio volumio[1017]: info: CoreStateMachine::ClearQueue Aug 22 12:51:59 volumio volumio[1017]: info: CoreStateMachine::stop Aug 22 12:51:59 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:51:59 volumio volumio[1017]: UNSET VOLATILE Aug 22 12:51:59 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Aug 22 12:51:59 volumio volumio[1017]: info: CoreStateMachine::updateTrackBlock Aug 22 12:51:59 volumio volumio[1017]: info: CorePlayQueue::getTrackBlock Aug 22 12:51:59 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:51:59 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:51:59 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:51:59 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:51:59 volumio volumio[1017]: info: CoreStateMachine::serviceStop Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::serviceStop Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::stop Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::clearPlayQueue Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::saveQueue Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushQueue Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::addQueueItems Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::addQueueItems Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/02 Best For Last.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/02 Best For Last.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/03 Chasing Pavements.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/03 Chasing Pavements.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/04 Cold Shoulder.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/04 Cold Shoulder.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/05 Crazy For You.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/05 Crazy For You.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/06 Melt My Heart To Stone.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/06 Melt My Heart To Stone.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/07 First Love.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/07 First Love.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/08 Right As Rain.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/08 Right As Rain.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/09 Make You Feel My Love.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/09 Make You Feel My Love.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/10 My Same.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/10 My Same.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/11 Tired.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/11 Tired.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/12 Hometown Glory.aif Aug 22 12:52:00 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/12 Hometown Glory.aif in service mpd Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F01%20Daydreamer.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F02%20Best%20For%20Last.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/02 Best For Last.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F03%20Chasing%20Pavements.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/03 Chasing Pavements.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F04%20Cold%20Shoulder.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/04 Cold Shoulder.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F05%20Crazy%20For%20You.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/05 Crazy For You.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F06%20Melt%20My%20Heart%20To%20Stone.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/06 Melt My Heart To Stone.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F07%20First%20Love.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/07 First Love.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F08%20Right%20As%20Rain.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/08 Right As Rain.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F09%20Make%20You%20Feel%20My%20Love.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/09 Make You Feel My Love.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F10%20My%20Same.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/10 My Same.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F11%20Tired.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/11 Tired.aif Aug 22 12:52:00 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F12%20Hometown%20Glory.aif&metadata=false Aug 22 12:52:00 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/12 Hometown Glory.aif Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::saveQueue Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushQueue Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::updateTrackBlock Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrackBlock Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPlay Aug 22 12:52:00 volumio volumio[1017]: UNSET VOLATILE Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::play index 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::stop Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:52:00 volumio volumio[1017]: UNSET VOLATILE Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::play index undefined Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::startPlaybackTimer Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::clearAddPlayTracks USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand add "USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif" Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: 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":"Concerto No. 3 in F Major, Op. 8, Rv 293, “l’autunno” (Autumn) I. Allegro","artist":"Anne Akiko Meyers","album":"the four seasons;The Vivaldi Album","uri":"USB/My Passport/AIFF 2.6T/1.Classic/Anne Akiko Meyers/the four seasons;The Vivaldi Album/07 Anne Akiko Meyers - Concerto No. 3 in F Major, Op. 8, Rv 293, “l’autunno” (Autumn) I. Allegro.aif","trackType":"aif"} Aug 22 12:52:00 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: No code Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 22 12:52:00 volumio volumio[1017]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 22 12:52:00 volumio volumio[1017]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 22 12:52:00 volumio volumio[1017]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 22 12:52:00 volumio volumio[1017]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 91ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 67ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 65ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 64ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 62ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 60ms Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: error: updateQueue error: null Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 58ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 17ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 14ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 14ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 12ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 11ms Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand play Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:00 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 30ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 26ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 20ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 19ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 18ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 17ms Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: info: Aug 22 12:52:00 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:00 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:00 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:00 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:00 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:00 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:00 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:00 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:00 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:00 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:00 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:00 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:00 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:00 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 114ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 111ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 110ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 110ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 109ms Aug 22 12:52:00 volumio volumio[1017]: info: ------------------------------ 109ms Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:00 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:01 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:01 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:01 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:01 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:01 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:01 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:01 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:01 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:01 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:01 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:01 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:01 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:01 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:01 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:01 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:01 volumio volumio[1017]: info: ------------------------------ 173ms Aug 22 12:52:01 volumio volumio[1017]: info: ------------------------------ 168ms Aug 22 12:52:01 volumio volumio[1017]: info: ------------------------------ 167ms Aug 22 12:52:01 volumio volumio[1017]: info: ------------------------------ 167ms Aug 22 12:52:01 volumio volumio[1017]: info: ------------------------------ 166ms Aug 22 12:52:01 volumio volumio[1017]: info: ------------------------------ 172ms Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::ClearQueue Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:52:12 volumio volumio[1017]: UNSET VOLATILE Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::stPlaybackTimer Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::updateTrackBlock Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrackBlock Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::serviceStop Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::serviceStop Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::stop Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::clearPlayQueue Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::saveQueue Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushQueue Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::addQueueItems Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::addQueueItems Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/02 Best For Last.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/02 Best For Last.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/03 Chasing Pavements.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/03 Chasing Pavements.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/04 Cold Shoulder.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/04 Cold Shoulder.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/05 Crazy For You.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/05 Crazy For You.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/06 Melt My Heart To Stone.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/06 Melt My Heart To Stone.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/07 First Love.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/07 First Love.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/08 Right As Rain.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/08 Right As Rain.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/09 Make You Feel My Love.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/09 Make You Feel My Love.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/10 My Same.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/10 My Same.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/11 Tired.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/11 Tired.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: Adding Item to queue: music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/12 Hometown Glory.aif Aug 22 12:52:12 volumio volumio[1017]: info: Exploding uri music-library/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/12 Hometown Glory.aif in service mpd Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F01%20Daydreamer.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F02%20Best%20For%20Last.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/02 Best For Last.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F03%20Chasing%20Pavements.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/03 Chasing Pavements.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F04%20Cold%20Shoulder.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/04 Cold Shoulder.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F05%20Crazy%20For%20You.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/05 Crazy For You.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F06%20Melt%20My%20Heart%20To%20Stone.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/06 Melt My Heart To Stone.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F07%20First%20Love.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/07 First Love.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F08%20Right%20As%20Rain.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/08 Right As Rain.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F09%20Make%20You%20Feel%20My%20Love.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/09 Make You Feel My Love.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F10%20My%20Same.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/10 My Same.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F11%20Tired.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/11 Tired.aif Aug 22 12:52:12 volumio volumio[1017]: info: ALBUMART /albumart?cacheid=744&web=Adele/19/extralarge&path=%2Fmnt%2FUSB%2FMy%20Passport%2FAIFF%202.6T%2F3.Pop%2FAdele%2F19%2F12%20Hometown%20Glory.aif&metadata=false Aug 22 12:52:12 volumio volumio[1017]: info: URI /mnt/USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/12 Hometown Glory.aif Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::saveQueue Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushQueue Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::updateTrackBlock Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrackBlock Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPlay Aug 22 12:52:12 volumio volumio[1017]: UNSET VOLATILE Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::play index 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:52:12 volumio volumio[1017]: UNSET VOLATILE Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::play index undefined Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::startPlaybackTimer Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::clearAddPlayTracks USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand stop Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand clear Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand add "USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif" Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: 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":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: No code Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: 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} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: No code Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: 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} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: No code Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: 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} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: No code Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: 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} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: No code Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: 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} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: No code Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 125ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 99ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 98ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 97ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 96ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 96ms Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: error: updateQueue error: null Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 124ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 30ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 29ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 27ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 25ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 24ms Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand play Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces system playlist update Aug 22 12:52:12 volumio volumio[1017]: info: Ignoring MPD Status Update Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 16ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 15ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 14ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 13ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 12ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 11ms Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: info: Aug 22 12:52:12 volumio volumio[1017]: ---------------------------- MPD announces state update: player Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::getState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand status Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseState Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus stop Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:12 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:12 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:12 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:12 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:12 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::volumioPushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 106ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 104ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 103ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 102ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 101ms Aug 22 12:52:12 volumio volumio[1017]: info: ------------------------------ 100ms Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: verbose: ControllerMpd::parseTrackInfo Aug 22 12:52:12 volumio volumio[1017]: info: ControllerMpd::pushState Aug 22 12:52:12 volumio volumio[1017]: info: CoreCommandRouter::servicePushState Aug 22 12:52:12 volumio volumio[1017]: info: CorePlayQueue::getTrack 0 Aug 22 12:52:12 volumio volumio[1017]: verbose: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Daydreamer","artist":"Adele","album":"19","uri":"USB/My Passport/AIFF 2.6T/3.Pop/Adele/19/01 Daydreamer.aif","trackType":"aif"} Aug 22 12:52:12 volumio volumio[1017]: verbose: CURRENT POSITION 0 Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState stateService play Aug 22 12:52:12 volumio volumio[1017]: info: CoreStateMachine::syncState currentStatus play Aug 22 12:52:12 volumio volumio[1017]: info: Received an update from plugin. extracting info from payload Aug 22 12:52:45 volumio systemd-journal[190]: Suppressed 94 messages from /system.slice/volumio.service Aug 22 12:52:45 volumio volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 22 12:52:45 volumio volumio[1017]: { Error: connect ETIMEDOUT 173.231.12.107:443 Aug 22 12:52:45 volumio volumio[1017]: at Object._errnoException (util.js:1022:11) Aug 22 12:52:45 volumio volumio[1017]: at _exceptionWithHostPort (util.js:1044:20) Aug 22 12:52:45 volumio volumio[1017]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) Aug 22 12:52:45 volumio volumio[1017]: code: 'ETIMEDOUT', Aug 22 12:52:45 volumio volumio[1017]: errno: 'ETIMEDOUT', Aug 22 12:52:45 volumio volumio[1017]: syscall: 'connect', Aug 22 12:52:45 volumio volumio[1017]: address: '173.231.12.107', Aug 22 12:52:45 volumio volumio[1017]: port: 443 } Aug 22 12:52:45 volumio volumio[1017]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 22 12:52:47 volumio sudo[7678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-22 12:51 Aug 22 12:52:47 volumio sudo[7678]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="74e4cc9de715c64d553d35948d017f973a622b6d" VOLUMIO_FE_VERSION="2be6c28eb9de74ec1f9662ca333f7bd51a232c33" VOLUMIO_BE_VERSION="259a7f2894e1376413ffac331be84e0e9a6173dd" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 24 22:42:43 CEST 2020" VOLUMIO_VERSION="2.834" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="e41ef0f29aa50c1af109d3064a380c69"