-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2025-12-30 13:36:32 CET. -- Dec 30 13:35:03 volumio volumio[1054]: verbose: New Socket.io Connection to 192.168.178.98 from 192.168.178.72 UA: Mozilla/5.0 (Linux; Android 14; SM-A528B Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/143.0.7499.34 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Dec 30 13:35:03 volumio volumio[1054]: info: CorePlayQueue::getTrack 31 Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 30 13:35:03 volumio volumio[1054]: info: Received Get System Info Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 13:35:03 volumio volumio[1054]: info: Discovery: Getting this device information Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Dec 30 13:35:03 volumio volumio[1054]: info: CorePlayQueue::getTrack 31 Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Dec 30 13:35:03 volumio volumio[1054]: info: CorePlayQueue::getTrack 31 Dec 30 13:35:03 volumio volumio[1054]: info: Listing playlists Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::volumioGetQueue Dec 30 13:35:03 volumio volumio[1054]: info: CoreStateMachine::getQueue Dec 30 13:35:03 volumio volumio[1054]: info: CorePlayQueue::getQueue Dec 30 13:35:03 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 30 13:35:29 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::ClearQueue Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::stPlaybackTimer Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 31 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::serviceStop Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 31 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::serviceStop Dec 30 13:35:29 volumio volumio[1054]: info: ControllerMpd::stop Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::clearPlayQueue Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::addQueueItems Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::addQueueItems Dec 30 13:35:29 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All Saints - Bootie Call.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All Saints - Bootie Call.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All SaintsJohnny DouglasPaul Wright III - Lady Marmalade - 1998 Remix.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All SaintsJohnny DouglasPaul Wright III - Lady Marmalade - 1998 Remix.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All SaintsNelle Hooper - Under the Bridge.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All SaintsNelle Hooper - Under the Bridge.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All Saints - Pure Shores.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All Saints - Pure Shores.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints/All%20Saints/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20Saints%20-%20Bootie%20Call.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All Saints - Bootie Call.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints%2FJohnny%20Douglas%2FPaul%20Wright%20III/All%20Saints/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20SaintsJohnny%20DouglasPaul%20Wright%20III%20-%20Lady%20Marmalade%20-%201998%20Remix.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All SaintsJohnny DouglasPaul Wright III - Lady Marmalade - 1998 Remix.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints%2FNelle%20Hooper/All%20Saints/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20SaintsNelle%20Hooper%20-%20Under%20the%20Bridge.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All SaintsNelle Hooper - Under the Bridge.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints/Greatest%20Hits%20Ever/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20Saints%20-%20Pure%20Shores.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All Saints - Pure Shores.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand stop took 55 milliseconds Dec 30 13:35:29 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPlay Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::play index 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::addQueueItems Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::addQueueItems Dec 30 13:35:29 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All Saints - Never Ever.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All Saints - Never Ever.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All SaintsTourist - Pure Shores.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All SaintsTourist - Pure Shores.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All Saints - Pure Shores - 2 da Beach U Don't Stop Remix.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All Saints - Pure Shores - 2 da Beach U Don't Stop Remix.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All SaintsCosmos - Pure Shores - Cosmos Remix.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All SaintsCosmos - Pure Shores - Cosmos Remix.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/All SaintsMark Stent - Black Coffee.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/All SaintsMark Stent - Black Coffee.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Jerry Lee Lewis - When the Saints Go Marching In.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Jerry Lee Lewis - When the Saints Go Marching In.mp3 in service mpd Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::play index undefined Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/All Saints - Pure Shores.mp3 Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints/Never%20Ever/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20Saints%20-%20Never%20Ever.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All Saints - Never Ever.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints%2FTourist/Pure%20Shores/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20SaintsTourist%20-%20Pure%20Shores.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All SaintsTourist - Pure Shores.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints/Pure%20Shores/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20Saints%20-%20Pure%20Shores%20-%202%20da%20Beach%20U%20Don't%20Stop%20Remix.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All Saints - Pure Shores - 2 da Beach U Don't Stop Remix.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints%2FCosmos/Pure%20Shores/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20SaintsCosmos%20-%20Pure%20Shores%20-%20Cosmos%20Remix.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All SaintsCosmos - Pure Shores - Cosmos Remix.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=All%20Saints%2FMark%20Stent/Saints%20%26%20Sinners/extralarge&path=%2Fmnt%2FINTERNAL%2FAll%20SaintsMark%20Stent%20-%20Black%20Coffee.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/All SaintsMark Stent - Black Coffee.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Jerry%20Lee%20Lewis/The%20All%20Time%20Greatest%20Hits%20of%20Rock'n'Roll/extralarge&path=%2Fmnt%2FINTERNAL%2FJerry%20Lee%20Lewis%20-%20When%20the%20Saints%20Go%20Marching%20In.mp3&metadata=false Dec 30 13:35:29 volumio volumio[1054]: info: URI /mnt/INTERNAL/Jerry Lee Lewis - When the Saints Go Marching In.mp3 Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand status took 37 milliseconds Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand stop took 8 milliseconds Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:29 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:29 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:35:29 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 52 milliseconds Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand clear took 52 milliseconds Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand status took 43 milliseconds Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand status took 43 milliseconds Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/All Saints - Pure Shores.mp3" Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:29 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Leave a Light On","artist":"Belinda Carlisle","album":"Leave a Light On","uri":"INTERNAL/Belinda Carlisle - Leave a Light On.mp3","trackType":"mp3"} Dec 30 13:35:29 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: No code Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 30 13:35:29 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: No code Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 30 13:35:29 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: No code Dec 30 13:35:29 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:29 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:29 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 161ms Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 101ms Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 102ms Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:35:29 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:35:29 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:35:29 volumio volumio[1054]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 30 13:35:29 volumio volumio[1054]: error: updateQueue error: null Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:35:29 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 122ms Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand add "INTERNAL/All Saints - Pure Shores.mp3" took 120 milliseconds Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 63ms Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 62ms Dec 30 13:35:29 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand play Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:35:29 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:35:29 volumio volumio[1054]: info: Dec 30 13:35:29 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:35:29 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 26ms Dec 30 13:35:29 volumio volumio[1054]: info: sendMpdCommand play took 15 milliseconds Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 15ms Dec 30 13:35:29 volumio volumio[1054]: info: ------------------------------ 14ms Dec 30 13:35:30 volumio volumio[1054]: info: Dec 30 13:35:30 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:30 volumio volumio[1054]: info: Dec 30 13:35:30 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:30 volumio volumio[1054]: info: Dec 30 13:35:30 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:30 volumio volumio[1054]: info: Dec 30 13:35:30 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand status took 10 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand status took 9 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand status took 9 milliseconds Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:30 volumio volumio[1054]: info: Dec 30 13:35:30 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:30 volumio volumio[1054]: info: Dec 30 13:35:30 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand status took 7 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand status took 4 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand status took 3 milliseconds Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1858,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:30 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1858,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:30 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:30 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1858,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:30 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:30 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: ------------------------------ 36ms Dec 30 13:35:30 volumio volumio[1054]: info: ------------------------------ 44ms Dec 30 13:35:30 volumio volumio[1054]: info: ------------------------------ 44ms Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 29 milliseconds Dec 30 13:35:30 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 29 milliseconds Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:30 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1858,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:30 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:30 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1858,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:30 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:30 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1858,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:30 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:30 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:30 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:30 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:30 volumio volumio[1054]: info: ------------------------------ 86ms Dec 30 13:35:30 volumio volumio[1054]: info: ------------------------------ 83ms Dec 30 13:35:30 volumio volumio[1054]: info: ------------------------------ 83ms Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioSeek Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::seek Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: TRACKBLOCK {"uri":"mnt/INTERNAL/All Saints - Pure Shores.mp3","service":"mpd","name":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=411&web=All%20Saints/Greatest%20Hits%20Ever/extralarge&path=%2FINTERNAL&metadata=false","duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","trackType":"mp3","channels":2} Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: ControllerMpd::seek Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:32 volumio volumio[1054]: error: null Dec 30 13:35:32 volumio volumio[1054]: info: Dec 30 13:35:32 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:32 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:32 volumio volumio[1054]: info: Dec 30 13:35:32 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:32 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:32 volumio volumio[1054]: info: Dec 30 13:35:32 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:35:32 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:35:32 volumio volumio[1054]: info: sendMpdCommand status took 7 milliseconds Dec 30 13:35:32 volumio volumio[1054]: info: sendMpdCommand status took 6 milliseconds Dec 30 13:35:32 volumio volumio[1054]: info: sendMpdCommand status took 5 milliseconds Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:35:32 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 3 milliseconds Dec 30 13:35:32 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 30 13:35:32 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:32 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:35:32 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61000,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:32 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:32 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:32 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61000,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:32 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:32 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:32 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":61000,"duration":266,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:35:32 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:35:32 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:32 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:35:32 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:32 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:35:32 volumio volumio[1054]: info: ------------------------------ 52ms Dec 30 13:35:32 volumio volumio[1054]: info: ------------------------------ 51ms Dec 30 13:35:32 volumio volumio[1054]: info: ------------------------------ 51ms Dec 30 13:35:38 volumio volumio[1054]: info: Saving local item Top Dec 30 13:35:38 volumio volumio[1054]: info: Pushing Favourites {"uri":"mnt/INTERNAL/All Saints - Pure Shores.mp3","favourite":false} Dec 30 13:35:38 volumio volumio[1054]: info: Listing playlists Dec 30 13:35:40 volumio volumio[1054]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Dec 30 13:35:40 volumio volumio[1054]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:95:19) Dec 30 13:35:40 volumio volumio[1054]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:115:37) Dec 30 13:35:40 volumio volumio[1054]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13 Dec 30 13:35:40 volumio volumio[1054]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Dec 30 13:35:40 volumio volumio[1054]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13) Dec 30 13:35:40 volumio volumio[1054]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3) Dec 30 13:35:40 volumio volumio[1054]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Dec 30 13:35:40 volumio volumio[1054]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Dec 30 13:35:40 volumio volumio[1054]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Dec 30 13:35:40 volumio volumio[1054]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Dec 30 13:35:40 volumio volumio[1054]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3) Dec 30 13:35:40 volumio volumio[1054]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10) Dec 30 13:35:40 volumio volumio[1054]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3) Dec 30 13:35:40 volumio volumio[1054]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12) Dec 30 13:35:40 volumio volumio[1054]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 13:35:43 volumio volumio[1054]: info: Discovery: Getting this device information Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Dec 30 13:35:43 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 13:35:43 volumio volumio[1054]: verbose: New Socket.io Connection to 192.168.178.84:3000 from 192.168.178.72 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 13:35:43 volumio volumio[1054]: info: Discovery: Getting this device information Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::volumioGetState Dec 30 13:35:43 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 13:35:43 volumio volumio[1054]: verbose: New Socket.io Connection to 192.168.178.98:3000 from 192.168.178.72 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 13:35:43 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 13:35:48 volumio volumio[1054]: Searching plugin music_service/mpd Dec 30 13:35:48 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 30 13:35:48 volumio volumio[1054]: info: All search sources collected, pushing search results Dec 30 13:35:49 volumio volumio[1054]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Dec 30 13:36:04 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::ClearQueue Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::stop Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::stPlaybackTimer Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::serviceStop Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::serviceStop Dec 30 13:36:04 volumio volumio[1054]: info: ControllerMpd::stop Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::clearPlayQueue Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::addQueueItems Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::addQueueItems Dec 30 13:36:04 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 Seven - Slave To The Music.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 Seven - Slave To The Music.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Grace Jones - Slave To The Rhythm.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Grace Jones - Slave To The Rhythm.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Slave To The Rhythm.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Slave To The Rhythm.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven/Best%20of/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20Seven%20-%20Slave%20To%20The%20Music.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 Seven - Slave To The Music.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Grace%20Jones/Island%20Life/extralarge&path=%2Fmnt%2FINTERNAL%2FGrace%20Jones%20-%20Slave%20To%20The%20Rhythm.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Grace Jones - Slave To The Rhythm.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Grace%20Jones/Island%20Life/extralarge&path=%2Fmnt%2FINTERNAL%2FSlave%20To%20The%20Rhythm.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Slave To The Rhythm.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Slave%20To%20The%20Music.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand stop took 53 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPlay Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::play index 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::addQueueItems Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::addQueueItems Dec 30 13:36:04 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Is It Love.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Is It Love.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Take Me Away.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Take Me Away.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Keep On Goin'.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Keep On Goin'.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Music Is My Life.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Music Is My Life.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Leave Them Alone.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Leave Them Alone.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - What Time Is It.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - What Time Is It.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Take Your Chance.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Take Your Chance.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Let's Stay.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Let's Stay.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music (Ferry & Garnefski Clubmix).mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music (Ferry & Garnefski Clubmix).mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 Seven - Is It Love - Dancability Clubmix.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: Exploding uri music-library/INTERNAL/Twenty 4 Seven - Is It Love - Dancability Clubmix.mp3 in service mpd Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::stop Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::play index undefined Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3 Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:04 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:04 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Is%20It%20Love.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Is It Love.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand status took 40 milliseconds Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:04 volumio volumio[1054]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Take%20Me%20Away.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Take Me Away.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Keep%20On%20Goin'.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Keep On Goin'.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Music%20Is%20My%20Life.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Music Is My Life.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Leave%20Them%20Alone.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Leave Them Alone.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20What%20Time%20Is%20It.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - What Time Is It.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Take%20Your%20Chance.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Take Your Chance.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Let's%20Stay.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Let's Stay.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven%2FStay-C/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20SevenStay-C%20-%20Slave%20To%20The%20Music%20(Ferry%20%26%20Garnefski%20Clubmix).mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music (Ferry & Garnefski Clubmix).mp3 Dec 30 13:36:04 volumio volumio[1054]: info: ALBUMART /albumart?cacheid=411&web=Twenty%204%20Seven/Slave%20To%20The%20Music/extralarge&path=%2Fmnt%2FINTERNAL%2FTwenty%204%20Seven%20-%20Is%20It%20Love%20-%20Dancability%20Clubmix.mp3&metadata=false Dec 30 13:36:04 volumio volumio[1054]: info: URI /mnt/INTERNAL/Twenty 4 Seven - Is It Love - Dancability Clubmix.mp3 Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand stop took 22 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand status took 20 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand status took 19 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 11 milliseconds Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:04 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Pure Shores","artist":"All Saints","album":"Greatest Hits Ever","uri":"INTERNAL/All Saints - Pure Shores.mp3","trackType":"mp3"} Dec 30 13:36:04 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:04 volumio volumio[1054]: info: No code Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 80ms Dec 30 13:36:04 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:36:04 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:36:04 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:04 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand clear took 66 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 66 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 67 milliseconds Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3" Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:04 volumio volumio[1054]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 13:36:04 volumio volumio[1054]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 99ms Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 97ms Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:04 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:04 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:04 volumio volumio[1054]: error: updateQueue error: null Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:04 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 31ms Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand add "INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3" took 26 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 16ms Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 15ms Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand play Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:04 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:04 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:04 volumio volumio[1054]: info: Dec 30 13:36:04 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 271ms Dec 30 13:36:04 volumio volumio[1054]: info: sendMpdCommand play took 270 milliseconds Dec 30 13:36:04 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 5ms Dec 30 13:36:04 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:04 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:04 volumio volumio[1054]: info: ------------------------------ 6ms Dec 30 13:36:05 volumio volumio[1054]: info: Dec 30 13:36:05 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:05 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:05 volumio volumio[1054]: info: Dec 30 13:36:05 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:05 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:05 volumio volumio[1054]: info: sendMpdCommand status took 474 milliseconds Dec 30 13:36:05 volumio volumio[1054]: info: sendMpdCommand status took 7 milliseconds Dec 30 13:36:05 volumio volumio[1054]: info: sendMpdCommand status took 2 milliseconds Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:05 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 30 13:36:05 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:05 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1085,"duration":244,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven/Stay-C","album":"Slave To The Music","uri":"INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:05 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:36:05 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1085,"duration":244,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven/Stay-C","album":"Slave To The Music","uri":"INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:05 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:05 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:05 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1577,"duration":244,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven/Stay-C","album":"Slave To The Music","uri":"INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:05 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:05 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:05 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1577,"duration":244,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven/Stay-C","album":"Slave To The Music","uri":"INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:05 volumio volumio[1054]: verbose: CURRENT POSITION 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:05 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:05 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:05 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:05 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:05 volumio volumio[1054]: info: ------------------------------ 511ms Dec 30 13:36:05 volumio volumio[1054]: info: ------------------------------ 530ms Dec 30 13:36:05 volumio volumio[1054]: info: ------------------------------ 64ms Dec 30 13:36:05 volumio volumio[1054]: info: ------------------------------ 62ms Dec 30 13:36:07 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:36:07 volumio volumio[1054]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 13:36:07 volumio volumio[1054]: info: CoreStateMachine::ClearQueue Dec 30 13:36:07 volumio volumio[1054]: info: CoreStateMachine::stop Dec 30 13:36:07 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:07 volumio volumio[1054]: info: CoreStateMachine::stPlaybackTimer Dec 30 13:36:07 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:36:07 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:36:07 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:07 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:07 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:07 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::serviceStop Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 3 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::serviceStop Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::stop Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::clearPlayQueue Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::addQueueItems Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::addQueueItems Dec 30 13:36:08 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 Seven - Slave To The Music.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 Seven - Slave To The Music.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPlay Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::play index 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::addQueueItems Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::addQueueItems Dec 30 13:36:08 volumio volumio[1054]: info: Preload queue cleared Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Grace Jones - Slave To The Rhythm.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Grace Jones - Slave To The Rhythm.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Slave To The Rhythm.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Slave To The Rhythm.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Is It Love.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Is It Love.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Take Me Away.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Take Me Away.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Keep On Goin'.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Keep On Goin'.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Music Is My Life.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Music Is My Life.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Leave Them Alone.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Leave Them Alone.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - What Time Is It.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - What Time Is It.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Take Your Chance.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Take Your Chance.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Let's Stay.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Let's Stay.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music (Ferry & Garnefski Clubmix).mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 SevenStay-C - Slave To The Music (Ferry & Garnefski Clubmix).mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Adding Item to queue: music-library/INTERNAL/Twenty 4 Seven - Is It Love - Dancability Clubmix.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: Using cached record of: music-library/INTERNAL/Twenty 4 Seven - Is It Love - Dancability Clubmix.mp3 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::stop Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushQueue Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::saveQueue Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::play index undefined Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::updateTrackBlock Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrackBlock Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::startPlaybackTimer Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Twenty 4 Seven - Slave To The Music.mp3 Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand stop took 47 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand stop took 15 milliseconds Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:08 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 15 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand clear took 14 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 13 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 11 milliseconds Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Twenty 4 Seven - Slave To The Music.mp3" Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: No code Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService stop Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: No code Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 50ms Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 49ms Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:08 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:08 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:08 volumio volumio[1054]: error: updateQueue error: null Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:08 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 85ms Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 82 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand add "INTERNAL/Twenty 4 Seven - Slave To The Music.mp3" took 82 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 44ms Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 43ms Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand play Dec 30 13:36:08 volumio volumio[1054]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 104ms Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:08 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces system playlist update Dec 30 13:36:08 volumio volumio[1054]: info: Ignoring MPD Status Update Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 39ms Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand play took 36 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 34ms Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 33ms Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: touch_display: Setting screensaver timeout to 120 seconds. Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 669 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 669 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 668 milliseconds Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: Dec 30 13:36:08 volumio volumio[1054]: ---------------------------- MPD announces state update: player Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::getState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand status Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 7 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 9 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 8 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand status took 7 milliseconds Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseState Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven","album":"Best of","uri":"INTERNAL/Twenty 4 Seven - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus stop Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven","album":"Best of","uri":"INTERNAL/Twenty 4 Seven - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:08 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":231,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven","album":"Best of","uri":"INTERNAL/Twenty 4 Seven - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:08 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 693ms Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 702ms Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 701ms Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 30 13:36:08 volumio volumio[1054]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:08 volumio volumio[1054]: verbose: ControllerMpd::parseTrackInfo Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven","album":"Best of","uri":"INTERNAL/Twenty 4 Seven - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:08 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven","album":"Best of","uri":"INTERNAL/Twenty 4 Seven - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:08 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: ControllerMpd::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::servicePushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1606,"duration":244,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Slave To The Music","artist":"Twenty 4 Seven","album":"Best of","uri":"INTERNAL/Twenty 4 Seven - Slave To The Music.mp3","trackType":"mp3"} Dec 30 13:36:08 volumio volumio[1054]: verbose: CURRENT POSITION 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState stateService play Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::syncState currentStatus play Dec 30 13:36:08 volumio volumio[1054]: info: Received an update from plugin. extracting info from payload Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: CoreStateMachine::pushState Dec 30 13:36:08 volumio volumio[1054]: info: CorePlayQueue::getTrack 0 Dec 30 13:36:08 volumio volumio[1054]: info: CoreCommandRouter::volumioPushState Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 98ms Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 96ms Dec 30 13:36:08 volumio volumio[1054]: info: ------------------------------ 96ms Dec 30 13:36:14 volumio volumio[1054]: info: Listing playlists Dec 30 13:36:15 volumio volumio[1054]: info: Saving local item Top Dec 30 13:36:15 volumio volumio[1054]: info: Pushing Favourites {"uri":"/mnt/INTERNAL/Twenty 4 Seven - Slave To The Music.mp3","favourite":false} Dec 30 13:36:15 volumio volumio[1054]: info: Listing playlists Dec 30 13:36:23 volumio volumio[1054]: Searching plugin music_service/mpd Dec 30 13:36:23 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 30 13:36:23 volumio volumio[1054]: info: All search sources collected, pushing search results Dec 30 13:36:25 volumio volumio[1054]: Searching plugin music_service/mpd Dec 30 13:36:25 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 30 13:36:25 volumio volumio[1054]: info: All search sources collected, pushing search results Dec 30 13:36:26 volumio volumio[1054]: Searching plugin music_service/mpd Dec 30 13:36:26 volumio volumio[1054]: info: CoreCommandRouter::executeOnPlugin: mpd , search Dec 30 13:36:27 volumio volumio[1054]: info: All search sources collected, pushing search results Dec 30 13:36:32 volumio volumio[1054]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 13:36:32 volumio volumio[1054]: TypeError: Cannot read property 'slice' of null Dec 30 13:36:32 volumio volumio[1054]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Dec 30 13:36:32 volumio volumio[1054]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Dec 30 13:36:32 volumio volumio[1054]: at Object.onceWrapper (events.js:422:26) Dec 30 13:36:32 volumio volumio[1054]: at ClientRequest.emit (events.js:315:20) Dec 30 13:36:32 volumio volumio[1054]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Dec 30 13:36:32 volumio volumio[1054]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Dec 30 13:36:32 volumio volumio[1054]: at TLSSocket.socketOnData (_http_client.js:509:22) Dec 30 13:36:32 volumio volumio[1054]: at TLSSocket.emit (events.js:315:20) Dec 30 13:36:32 volumio volumio[1054]: at addChunk (internal/streams/readable.js:309:12) Dec 30 13:36:32 volumio volumio[1054]: at readableAddChunk (internal/streams/readable.js:284:9) Dec 30 13:36:32 volumio volumio[1054]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Dec 30 13:36:32 volumio volumio[1054]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Dec 30 13:36:32 volumio volumio[1054]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 13:36:32 volumio sudo[27340]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 13:35 Dec 30 13:36:32 volumio sudo[27340]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"