Mar 27 11:22:05 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::ClearQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::stop Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::clearPlayQueue Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/01 - Hay Amores.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/01 - Hay Amores.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::updateTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::getTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPlay Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::play index 0 Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/02 - Despedida.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/02 - Despedida.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/03 - Pienso En Ti.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/03 - Pienso En Ti.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/04 - Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/04 - Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/05 - In The Time Of Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/05 - In The Time Of Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/06 - My New Life.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/06 - My New Life.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/07 - White Suite.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/07 - White Suite.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/09 - Divided Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/09 - Divided Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/10 - 1900.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/10 - 1900.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/11 - Escolastica.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/11 - Escolastica.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/12 - Confused Transito.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/12 - Confused Transito.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/13 - Fiorentino.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/13 - Fiorentino.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/14 - The Boat.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/14 - The Boat.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/15 - The Widow.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/15 - The Widow.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/16 - Sex Drum.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/16 - Sex Drum.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/17 - Los Dos.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/17 - Los Dos.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/18 - Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/18 - Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/19 - Second Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/19 - Second Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/20 - The Girls.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/20 - The Girls.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/21 - Forever.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/21 - Forever.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/22 - Realejo.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/22 - Realejo.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::stop Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::play index undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::updateTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::getTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:05 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::ClearQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::stop Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::clearPlayQueue Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/01 - Hay Amores.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/01 - Hay Amores.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::updateTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::getTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPlay Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::play index 0 Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::addQueueItems Mar 27 11:22:05 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/02 - Despedida.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/02 - Despedida.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/03 - Pienso En Ti.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/03 - Pienso En Ti.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/04 - Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/04 - Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/05 - In The Time Of Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/05 - In The Time Of Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/06 - My New Life.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/06 - My New Life.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/07 - White Suite.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/07 - White Suite.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/09 - Divided Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/09 - Divided Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/10 - 1900.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/10 - 1900.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/11 - Escolastica.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/11 - Escolastica.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/12 - Confused Transito.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/12 - Confused Transito.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/13 - Fiorentino.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/13 - Fiorentino.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/14 - The Boat.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/14 - The Boat.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/15 - The Widow.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/15 - The Widow.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/16 - Sex Drum.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/16 - Sex Drum.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/17 - Los Dos.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/17 - Los Dos.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/18 - Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/18 - Cholera.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/19 - Second Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/19 - Second Love.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/20 - The Girls.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/20 - The Girls.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/21 - Forever.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/21 - Forever.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/22 - Realejo.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/22 - Realejo.mp3 Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::stop Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::play index undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:05 volumio volumio[1276]: info: CoreStateMachine::updateTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::getTrackBlock Mar 27 11:22:05 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:06 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:06 volumio volumio[1276]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::ClearQueue Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::stop Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::clearPlayQueue Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:06 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::addQueueItems Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::addQueueItems Mar 27 11:22:06 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/01 - Hay Amores.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/01 - Hay Amores.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::updateTrackBlock Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::getTrackBlock Mar 27 11:22:06 volumio volumio[1276]: info: CoreCommandRouter::volumioPlay Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::play index 0 Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::addQueueItems Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::addQueueItems Mar 27 11:22:06 volumio volumio[1276]: info: Preload queue cleared Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/02 - Despedida.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/02 - Despedida.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/03 - Pienso En Ti.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/03 - Pienso En Ti.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/04 - Love.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/04 - Love.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/05 - In The Time Of Cholera.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/05 - In The Time Of Cholera.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/06 - My New Life.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/06 - My New Life.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/07 - White Suite.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/07 - White Suite.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/09 - Divided Love.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/09 - Divided Love.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/10 - 1900.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/10 - 1900.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/11 - Escolastica.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/11 - Escolastica.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/12 - Confused Transito.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/12 - Confused Transito.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/13 - Fiorentino.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/13 - Fiorentino.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/14 - The Boat.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/14 - The Boat.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/15 - The Widow.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/15 - The Widow.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/16 - Sex Drum.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/16 - Sex Drum.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/17 - Los Dos.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/17 - Los Dos.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/18 - Cholera.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/18 - Cholera.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/19 - Second Love.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/19 - Second Love.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/20 - The Girls.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/20 - The Girls.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/21 - Forever.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/21 - Forever.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Adding Item to queue: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/22 - Realejo.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: Using cached record of: music-library/USB/5E18FFD418FFA963/Soundtracks/Love in the Time of Cholera/22 - Realejo.mp3 Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::stop Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:06 volumio volumio[1276]: info: CoreCommandRouter::volumioPushQueue Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::saveQueue Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::play index undefined Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:06 volumio volumio[1276]: info: CoreStateMachine::updateTrackBlock Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::getTrackBlock Mar 27 11:22:06 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:29 volumio volumio[1276]: info: CoreCommandRouter::volumioPlay Mar 27 11:22:29 volumio volumio[1276]: info: CoreStateMachine::play index undefined Mar 27 11:22:29 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:29 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 11:22:35 volumio volumio[1276]: info: Retrieving Cloud Streaming UI Mar 27 11:22:35 volumio volumio[1276]: info: Getting Tidal Cloud Configuration Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 11:22:35 volumio volumio[1276]: info: Getting Qobuz Cloud Configuration Mar 27 11:22:35 volumio volumio[1276]: info: Asking plugin for UI Config Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 11:22:35 volumio volumio[1276]: info: Getting Spotify Cloud Configuration Mar 27 11:22:35 volumio volumio[1276]: info: Asking plugin for UI Config Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 11:22:35 volumio volumio[1276]: info: Saving Spotify Acccount Mar 27 11:22:35 volumio volumio[1276]: info: Got Tidal Cloud Configuration Mar 27 11:22:35 volumio volumio[1276]: info: Got it Mar 27 11:22:35 volumio volumio[1276]: info: Got it Mar 27 11:22:35 volumio volumio[1276]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 27 11:22:35 volumio volumio[1276]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::volumioGetBrowseSources Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::volumioGetBrowseSources Mar 27 11:22:35 volumio volumio[1276]: info: CoreCommandRouter::volumioGetBrowseSources Mar 27 11:22:36 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 27 11:22:36 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand rescan Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:22:38 volumio volumio[1276]: info: Mar 27 11:22:38 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:22:38 volumio volumio[1276]: info: sendMpdCommand rescan took 10 milliseconds Mar 27 11:22:38 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:22:38 volumio volumio[1276]: info: Mar 27 11:22:38 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:22:38 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:22:38 volumio volumio[1276]: info: Mar 27 11:22:38 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:22:38 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:22:38 volumio volumio[1276]: info: sendMpdCommand status took 23 milliseconds Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:22:38 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:22:38 volumio volumio[1276]: info: sendMpdCommand status took 137 milliseconds Mar 27 11:22:38 volumio volumio[1276]: info: sendMpdCommand status took 136 milliseconds Mar 27 11:22:38 volumio volumio[1276]: info: sendMpdCommand status took 135 milliseconds Mar 27 11:22:38 volumio volumio[1276]: info: sendMpdCommand status took 136 milliseconds Mar 27 11:22:38 volumio volumio[1276]: info: sendMpdCommand status took 135 milliseconds Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:22:38 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:22:38 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:22:38 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:22:38 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:22:38 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: No code Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:22:38 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: No code Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:22:38 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: No code Mar 27 11:22:38 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:22:38 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:38 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:22:38 volumio volumio[1276]: info: ------------------------------ 278ms Mar 27 11:22:38 volumio volumio[1276]: info: ------------------------------ 370ms Mar 27 11:22:38 volumio volumio[1276]: info: ------------------------------ 370ms Mar 27 11:22:40 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 27 11:22:40 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 27 11:22:40 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand rescan Mar 27 11:22:40 volumio volumio[1276]: info: sendMpdCommand rescan took 5 milliseconds Mar 27 11:22:44 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 27 11:22:45 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 27 11:22:45 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand update Mar 27 11:22:45 volumio volumio[1276]: info: sendMpdCommand update took 5 milliseconds Mar 27 11:22:48 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 27 11:22:52 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 27 11:22:53 volumio volumio[1276]: info: CoreCommandRouter::volumioPlay Mar 27 11:22:53 volumio volumio[1276]: info: CoreStateMachine::play index undefined Mar 27 11:22:53 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:53 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:54 volumio volumio[1276]: info: CoreCommandRouter::volumioPlay Mar 27 11:22:54 volumio volumio[1276]: info: CoreStateMachine::play index undefined Mar 27 11:22:54 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:22:54 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:22:59 volumio volumio[1276]: info: CoreCommandRouter::volumioSeek Mar 27 11:22:59 volumio volumio[1276]: info: CoreStateMachine::seek Mar 27 11:22:59 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::volumioPlay Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::play index undefined Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:00 volumio volumio[1276]: info: Mar 27 11:23:00 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: Mar 27 11:23:00 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:00 volumio volumio[1276]: info: Mar 27 11:23:00 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: Mar 27 11:23:00 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:00 volumio volumio[1276]: info: Mar 27 11:23:00 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: Mar 27 11:23:00 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:00 volumio volumio[1276]: info: sendMpdCommand status took 334 milliseconds Mar 27 11:23:00 volumio volumio[1276]: info: sendMpdCommand status took 334 milliseconds Mar 27 11:23:00 volumio volumio[1276]: info: sendMpdCommand status took 334 milliseconds Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:00 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:00 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:00 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:00 volumio volumio[1276]: info: No code Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:00 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:00 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:00 volumio volumio[1276]: info: No code Mar 27 11:23:00 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:00 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:00 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:00 volumio volumio[1276]: info: ------------------------------ 500ms Mar 27 11:23:00 volumio volumio[1276]: info: ------------------------------ 500ms Mar 27 11:23:01 volumio volumio[1276]: info: sendMpdCommand status took 651 milliseconds Mar 27 11:23:01 volumio volumio[1276]: info: sendMpdCommand status took 650 milliseconds Mar 27 11:23:01 volumio volumio[1276]: info: sendMpdCommand status took 650 milliseconds Mar 27 11:23:01 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:01 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:01 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:01 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:01 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:01 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: No code Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:01 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: No code Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: ------------------------------ 777ms Mar 27 11:23:01 volumio volumio[1276]: info: ------------------------------ 777ms Mar 27 11:23:01 volumio volumio[1276]: info: sendMpdCommand status took 930 milliseconds Mar 27 11:23:01 volumio volumio[1276]: info: sendMpdCommand status took 928 milliseconds Mar 27 11:23:01 volumio volumio[1276]: info: sendMpdCommand status took 928 milliseconds Mar 27 11:23:01 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:01 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:01 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:01 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:01 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:01 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: No code Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:01 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: No code Mar 27 11:23:01 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:01 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:01 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:01 volumio volumio[1276]: info: ------------------------------ 1075ms Mar 27 11:23:01 volumio volumio[1276]: info: ------------------------------ 1075ms Mar 27 11:23:12 volumio volumio[1276]: info: Discovery: A device disappeared from network Mar 27 11:23:14 volumio volumio[1276]: info: Discovery: Disconnected from remote: 192.168.181.6 Mar 27 11:23:14 volumio volumio[1276]: info: Discovery: Disconnected from remote: 192.168.181.6 Mar 27 11:23:14 volumio volumio[1276]: info: Discovery: Disconnected from remote: 192.168.181.6 Mar 27 11:23:14 volumio volumio[1276]: info: Discovery: Disconnected from remote: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:19 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:21 volumio wpa_supplicant[1237]: RRM: Ignoring radio measurement request: Not RRM network Mar 27 11:23:21 volumio wpa_supplicant[1237]: wlan0: WNM: Preferred List Available Mar 27 11:23:21 volumio wpa_supplicant[1237]: wlan0: Trying to associate with 36:31:c4:1a:b1:33 (SSID='Tiglin-416' freq=2462 MHz) Mar 27 11:23:21 volumio dhcpcd[783]: wlan0: carrier lost - roaming Mar 27 11:23:21 volumio dhcpcd[783]: wlan0: changing route to 192.168.181.0/24 Mar 27 11:23:21 volumio kernel: ieee80211 phy0: brcmf_p2p_send_action_frame: Unknown Frame: category 0xa, action 0x8 Mar 27 11:23:21 volumio dhcpcd[783]: wlan0: changing default route via 192.168.181.1 Mar 27 11:23:22 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:22 volumio volumio[1276]: info: Mar 27 11:23:22 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: Mar 27 11:23:22 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:22 volumio volumio[1276]: info: Mar 27 11:23:22 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: Mar 27 11:23:22 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:22 volumio volumio[1276]: info: Mar 27 11:23:22 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: Mar 27 11:23:22 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:22 volumio volumio[1276]: info: Received Get System Info Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 27 11:23:22 volumio volumio[1276]: info: Discovery: Getting this device information Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioGetState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 364 milliseconds Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 364 milliseconds Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 362 milliseconds Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:22 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:22 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: No code Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:22 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: No code Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: ------------------------------ 548ms Mar 27 11:23:22 volumio volumio[1276]: info: ------------------------------ 550ms Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 690 milliseconds Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 691 milliseconds Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 690 milliseconds Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:22 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:22 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: No code Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:22 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: No code Mar 27 11:23:22 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:22 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:22 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:22 volumio volumio[1276]: info: ------------------------------ 791ms Mar 27 11:23:22 volumio volumio[1276]: info: ------------------------------ 792ms Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 926 milliseconds Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 926 milliseconds Mar 27 11:23:22 volumio volumio[1276]: info: sendMpdCommand status took 925 milliseconds Mar 27 11:23:22 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:23 volumio volumio[1276]: info: Command Router : Notfying DB Updatetrue Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:23 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:23 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:23 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:23 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:23 volumio volumio[1276]: info: No code Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:23 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 27 11:23:23 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:23 volumio volumio[1276]: info: No code Mar 27 11:23:23 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:23 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:23 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:23 volumio volumio[1276]: info: ------------------------------ 1019ms Mar 27 11:23:23 volumio volumio[1276]: info: ------------------------------ 1020ms Mar 27 11:23:23 volumio ntpd[989]: IO: Deleting interface #6 wlan0, 192.168.181.9#123, interface stats: received=16, sent=16, dropped=0, active_time=129 secs Mar 27 11:23:23 volumio ntpd[989]: PROTO: 193.93.164.194 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio ntpd[989]: PROTO: 162.159.200.123 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio ntpd[989]: PROTO: 147.52.190.11 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio ntpd[989]: PROTO: 185.201.254.21 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio ntpd[989]: PROTO: 162.159.200.1 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio ntpd[989]: PROTO: 193.239.214.226 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio ntpd[989]: PROTO: 62.1.105.163 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio ntpd[989]: PROTO: 44.32.63.52 unlink local addr 192.168.181.9 -> Mar 27 11:23:23 volumio volumio5-onboarding[1744]: time=2026-03-27T11:23:23.254+02:00 level=INFO msg="service successfully established" component=discovery/localnet Mar 27 11:23:25 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:25 volumio volumio[1276]: info: Mar 27 11:23:25 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: Mar 27 11:23:25 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:25 volumio volumio[1276]: info: Mar 27 11:23:25 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: Mar 27 11:23:25 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: MPD Database updated - AlbumList cache refreshed Mar 27 11:23:25 volumio volumio[1276]: info: Mar 27 11:23:25 volumio volumio[1276]: ---------------------------- MPD announces state update: database Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: Mar 27 11:23:25 volumio volumio[1276]: ---------------------------- MPD announces state update: update Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::getState Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::sendMpdCommand status Mar 27 11:23:25 volumio volumio[1276]: info: sendMpdCommand status took 237 milliseconds Mar 27 11:23:25 volumio volumio[1276]: info: sendMpdCommand status took 237 milliseconds Mar 27 11:23:25 volumio volumio[1276]: info: sendMpdCommand status took 236 milliseconds Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:25 volumio volumio[1276]: info: Command Router : Notfying DB Updatefalse Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:25 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: 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} Mar 27 11:23:25 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:25 volumio volumio[1276]: info: No code Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:25 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: 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} Mar 27 11:23:25 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:25 volumio volumio[1276]: info: No code Mar 27 11:23:25 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:25 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:25 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:25 volumio volumio[1276]: info: ------------------------------ 349ms Mar 27 11:23:25 volumio volumio[1276]: info: ------------------------------ 349ms Mar 27 11:23:26 volumio volumio[1276]: info: sendMpdCommand status took 567 milliseconds Mar 27 11:23:26 volumio volumio[1276]: info: sendMpdCommand status took 567 milliseconds Mar 27 11:23:26 volumio volumio[1276]: info: sendMpdCommand status took 567 milliseconds Mar 27 11:23:26 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:26 volumio volumio[1276]: info: Command Router : Notfying DB Updatefalse Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:26 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:26 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:26 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: 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} Mar 27 11:23:26 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: No code Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: 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} Mar 27 11:23:26 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: No code Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: ------------------------------ 633ms Mar 27 11:23:26 volumio volumio[1276]: info: ------------------------------ 634ms Mar 27 11:23:26 volumio volumio[1276]: info: sendMpdCommand status took 736 milliseconds Mar 27 11:23:26 volumio volumio[1276]: info: sendMpdCommand status took 735 milliseconds Mar 27 11:23:26 volumio volumio[1276]: info: sendMpdCommand status took 736 milliseconds Mar 27 11:23:26 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:26 volumio volumio[1276]: info: Command Router : Notfying DB Updatefalse Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::Close All Modals sent Mar 27 11:23:26 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:26 volumio volumio[1276]: verbose: ControllerMpd::parseState Mar 27 11:23:26 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: 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} Mar 27 11:23:26 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: No code Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: ControllerMpd::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::servicePushState Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: 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} Mar 27 11:23:26 volumio volumio[1276]: verbose: CURRENT POSITION 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState stateService stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::syncState currentStatus stop Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: No code Mar 27 11:23:26 volumio volumio[1276]: info: CoreStateMachine::pushState Mar 27 11:23:26 volumio volumio[1276]: info: CorePlayQueue::getTrack 0 Mar 27 11:23:26 volumio volumio[1276]: info: CoreCommandRouter::volumioPushState Mar 27 11:23:26 volumio volumio[1276]: info: ------------------------------ 772ms Mar 27 11:23:26 volumio volumio[1276]: info: ------------------------------ 773ms Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection error: 192.168.181.6 Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:27 volumio volumio[1276]: info: Discovery: Remote connection timeout: 192.168.181.6 Mar 27 11:23:31 volumio volumio[1276]: info: CoreCommandRouter::volumioGetVisibleSources Mar 27 11:23:31 volumio volumio[1276]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 27 11:23:31 volumio volumio[1276]: info: CoreCommandRouter::volumioGetQueue Mar 27 11:23:31 volumio volumio[1276]: info: CoreStateMachine::getQueue Mar 27 11:23:31 volumio volumio[1276]: info: CorePlayQueue::getQueue Mar 27 11:23:31 volumio wpa_supplicant[1237]: wlan0: Authentication with 36:31:c4:1a:b1:33 timed out. Mar 27 11:23:31 volumio wpa_supplicant[1237]: wlan0: CTRL-EVENT-DISCONNECTED bssid=36:31:c4:1a:b1:33 reason=3 locally_generated=1 Mar 27 11:23:31 volumio wpa_supplicant[1237]: BSSID 36:31:c4:1a:b1:33 ignore list count incremented to 2, ignoring for 10 seconds Mar 27 11:23:31 volumio wpa_supplicant[1237]: wlan0: CTRL-EVENT-DSCP-POLICY clear_all Mar 27 11:23:31 volumio wpa_supplicant[1237]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=CORE type=WORLD Mar 27 11:23:31 volumio wpa_supplicant[1237]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=USER type=COUNTRY alpha2=GR Mar 27 11:23:32 volumio volumio[1276]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 11:23:32 volumio volumio[1276]: Error: read ETIMEDOUT Mar 27 11:23:32 volumio volumio[1276]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:217:20) { Mar 27 11:23:32 volumio volumio[1276]: errno: -110, Mar 27 11:23:32 volumio volumio[1276]: code: 'ETIMEDOUT', Mar 27 11:23:32 volumio volumio[1276]: syscall: 'read' Mar 27 11:23:32 volumio volumio[1276]: } Mar 27 11:23:32 volumio volumio[1276]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 27 11:23:32 volumio sudo[3112]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-27 11:22' Mar 27 11:23:32 volumio sudo[3112]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"