-- Logs begin at Thu 2019-02-14 13:11:59 MSK, end at Sun 2024-04-07 09:31:05 MSK. -- Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioNext Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::next Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 18 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::serviceStop Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 18 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::serviceStop Apr 07 09:30:03 volumio volumio[948]: info: ControllerMpd::stop Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:03 volumio volumio[948]: info: Apr 07 09:30:03 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:03 volumio volumio[948]: info: sendMpdCommand stop took 38 milliseconds Apr 07 09:30:03 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::play index undefined Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 19 Apr 07 09:30:03 volumio volumio[948]: info: Apr 07 09:30:03 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:03 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:03 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds Apr 07 09:30:03 volumio volumio[948]: info: sendMpdCommand status took 3 milliseconds Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 07 09:30:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:03 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: 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":"You Get What You Give","artist":"New Radicals","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/19 - New Radicals - You Get What You Give.mp3","trackType":"mp3"} Apr 07 09:30:03 volumio volumio[948]: verbose: CURRENT POSITION 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:03 volumio volumio[948]: info: No code Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:03 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: 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":"You Get What You Give","artist":"New Radicals","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/19 - New Radicals - You Get What You Give.mp3","trackType":"mp3"} Apr 07 09:30:03 volumio volumio[948]: verbose: CURRENT POSITION 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:03 volumio volumio[948]: info: No code Apr 07 09:30:03 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:03 volumio volumio[948]: info: ------------------------------ 50ms Apr 07 09:30:03 volumio volumio[948]: info: ------------------------------ 46ms Apr 07 09:30:03 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 09:30:04 volumio volumio[948]: info: Discovery: Getting this device information Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::volumioGetState Apr 07 09:30:04 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 07 09:30:04 volumio volumio[948]: info: Discovery: Getting this device information Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::volumioGetState Apr 07 09:30:04 volumio volumio[948]: info: CorePlayQueue::getTrack 0 Apr 07 09:30:04 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::volumioNext Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::next Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::play index undefined Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3 Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand stop took 1 milliseconds Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:08 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand clear took 1 milliseconds Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3" Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:08 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:08 volumio volumio[948]: error: updateQueue error: null Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:08 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 2ms Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3" took 2 milliseconds Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 1ms Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:08 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 2ms Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand play took 2 milliseconds Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 2ms Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand status took 15 milliseconds Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand status took 15 milliseconds Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tubthumping","artist":"Chumbawamba","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3","trackType":"mp3"} Apr 07 09:30:08 volumio volumio[948]: verbose: CURRENT POSITION 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 18ms Apr 07 09:30:08 volumio volumio[948]: info: Apr 07 09:30:08 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand status took 2 milliseconds Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tubthumping","artist":"Chumbawamba","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3","trackType":"mp3"} Apr 07 09:30:08 volumio volumio[948]: verbose: CURRENT POSITION 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:08 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 48ms Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand playlistinfo took 29 milliseconds Apr 07 09:30:08 volumio volumio[948]: info: sendMpdCommand playlistinfo took 30 milliseconds Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:08 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tubthumping","artist":"Chumbawamba","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3","trackType":"mp3"} Apr 07 09:30:08 volumio volumio[948]: verbose: CURRENT POSITION 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:08 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:08 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":279,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tubthumping","artist":"Chumbawamba","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3","trackType":"mp3"} Apr 07 09:30:08 volumio volumio[948]: verbose: CURRENT POSITION 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:08 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:08 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:08 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:08 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 93ms Apr 07 09:30:08 volumio volumio[948]: info: ------------------------------ 90ms Apr 07 09:30:08 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioNext Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::next Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::serviceStop Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 1 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::serviceStop Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::stop Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand stop took 48 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::play index undefined Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3 Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand stop took 2 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand status took 1 milliseconds Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:09 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:09 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand clear took 7 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3" Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: 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":"Tubthumping","artist":"Chumbawamba","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/02 - Chumbawamba - Tubthumping.mp3","trackType":"mp3"} Apr 07 09:30:09 volumio volumio[948]: verbose: CURRENT POSITION 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: No code Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 35ms Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 32ms Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:09 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:09 volumio volumio[948]: error: updateQueue error: null Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:09 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 30ms Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3" took 25 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 4ms Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:09 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 16ms Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand play took 14 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 14ms Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand status took 20 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand status took 20 milliseconds Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:09 volumio volumio[948]: info: Apr 07 09:30:09 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand status took 3 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand status took 2 milliseconds Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Two Princes","artist":"Spin Doctors","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3","trackType":"mp3"} Apr 07 09:30:09 volumio volumio[948]: verbose: CURRENT POSITION 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Two Princes","artist":"Spin Doctors","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3","trackType":"mp3"} Apr 07 09:30:09 volumio volumio[948]: verbose: CURRENT POSITION 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:09 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 36ms Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 41ms Apr 07 09:30:09 volumio volumio[948]: info: sendMpdCommand playlistinfo took 20 milliseconds Apr 07 09:30:09 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Two Princes","artist":"Spin Doctors","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3","trackType":"mp3"} Apr 07 09:30:09 volumio volumio[948]: verbose: CURRENT POSITION 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:09 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":256,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Two Princes","artist":"Spin Doctors","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3","trackType":"mp3"} Apr 07 09:30:09 volumio volumio[948]: verbose: CURRENT POSITION 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:09 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:09 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:09 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 67ms Apr 07 09:30:09 volumio volumio[948]: info: ------------------------------ 65ms Apr 07 09:30:10 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioNext Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::next Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::serviceStop Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 2 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::serviceStop Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::stop Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand stop took 43 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::play index undefined Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/04 - Deep Blue Something - Breakfast At Tiffany's.mp3 Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand status took 10 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand stop took 9 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:11 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand clear took 11 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/04 - Deep Blue Something - Breakfast At Tiffany's.mp3" Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: 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":"Two Princes","artist":"Spin Doctors","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/03 - Spin Doctors - Two Princes.mp3","trackType":"mp3"} Apr 07 09:30:11 volumio volumio[948]: verbose: CURRENT POSITION 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: info: No code Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 66ms Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 61ms Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:11 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:11 volumio volumio[948]: error: updateQueue error: null Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:11 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 68ms Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/04 - Deep Blue Something - Breakfast At Tiffany's.mp3" took 66 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 23ms Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:11 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:11 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 62ms Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand play took 60 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 40ms Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:11 volumio volumio[948]: info: Apr 07 09:30:11 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand status took 13 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand status took 16 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand status took 18 milliseconds Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand playlistinfo took 15 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 07 09:30:11 volumio volumio[948]: info: sendMpdCommand playlistinfo took 16 milliseconds Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:11 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":257,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Breakfast At Tiffany's","artist":"Deep Blue Something","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/04 - Deep Blue Something - Breakfast At Tiffany's.mp3","trackType":"mp3"} Apr 07 09:30:11 volumio volumio[948]: verbose: CURRENT POSITION 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":257,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Breakfast At Tiffany's","artist":"Deep Blue Something","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/04 - Deep Blue Something - Breakfast At Tiffany's.mp3","trackType":"mp3"} Apr 07 09:30:11 volumio volumio[948]: verbose: CURRENT POSITION 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:11 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":257,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Breakfast At Tiffany's","artist":"Deep Blue Something","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/04 - Deep Blue Something - Breakfast At Tiffany's.mp3","trackType":"mp3"} Apr 07 09:30:11 volumio volumio[948]: verbose: CURRENT POSITION 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:11 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:11 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:11 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 57ms Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 86ms Apr 07 09:30:11 volumio volumio[948]: info: ------------------------------ 93ms Apr 07 09:30:11 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 07 09:30:12 volumio volumio[948]: info: CoreCommandRouter::volumioNext Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::next Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:12 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:12 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:12 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:12 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::serviceStop Apr 07 09:30:12 volumio volumio[948]: info: CorePlayQueue::getTrack 3 Apr 07 09:30:12 volumio volumio[948]: info: CoreCommandRouter::serviceStop Apr 07 09:30:12 volumio volumio[948]: info: ControllerMpd::stop Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:12 volumio volumio[948]: info: Apr 07 09:30:12 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:12 volumio volumio[948]: info: sendMpdCommand stop took 41 milliseconds Apr 07 09:30:12 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::play index undefined Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:12 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer Apr 07 09:30:12 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3 Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:12 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:12 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:12 volumio volumio[948]: info: Apr 07 09:30:12 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:12 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:12 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds Apr 07 09:30:12 volumio volumio[948]: info: sendMpdCommand stop took 4 milliseconds Apr 07 09:30:12 volumio volumio[948]: info: sendMpdCommand status took 3 milliseconds Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:12 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:13 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:13 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand clear took 11 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3" Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: 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":"Breakfast At Tiffany's","artist":"Deep Blue Something","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/04 - Deep Blue Something - Breakfast At Tiffany's.mp3","trackType":"mp3"} Apr 07 09:30:13 volumio volumio[948]: verbose: CURRENT POSITION 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: No code Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 52ms Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 50ms Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:13 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:13 volumio volumio[948]: error: updateQueue error: null Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:13 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 41ms Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3" took 40 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 5ms Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:13 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 19ms Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand play took 16 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 14ms Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand status took 26 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand status took 19 milliseconds Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:13 volumio volumio[948]: info: Apr 07 09:30:13 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand status took 11 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I'd Lie For You (And That's The Truth)","artist":"Meat Loaf","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3","trackType":"mp3"} Apr 07 09:30:13 volumio volumio[948]: verbose: CURRENT POSITION 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":401,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I'd Lie For You (And That's The Truth)","artist":"Meat Loaf","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3","trackType":"mp3"} Apr 07 09:30:13 volumio volumio[948]: verbose: CURRENT POSITION 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:13 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 56ms Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 57ms Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand status took 37 milliseconds Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand playlistinfo took 34 milliseconds Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":171,"duration":401,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I'd Lie For You (And That's The Truth)","artist":"Meat Loaf","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3","trackType":"mp3"} Apr 07 09:30:13 volumio volumio[948]: verbose: CURRENT POSITION 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:13 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 63ms Apr 07 09:30:13 volumio volumio[948]: info: sendMpdCommand playlistinfo took 111 milliseconds Apr 07 09:30:13 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:13 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":342,"duration":401,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I'd Lie For You (And That's The Truth)","artist":"Meat Loaf","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3","trackType":"mp3"} Apr 07 09:30:13 volumio volumio[948]: verbose: CURRENT POSITION 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:13 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:13 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:13 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:13 volumio volumio[948]: info: ------------------------------ 171ms Apr 07 09:30:13 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioNext Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::next Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::serviceStop Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 4 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::serviceStop Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::stop Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand stop took 40 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::play index undefined Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3 Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand status took 2 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand stop took 1 milliseconds Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:14 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand clear took 13 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand status took 12 milliseconds Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3" Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: 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":"I'd Lie For You (And That's The Truth)","artist":"Meat Loaf","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/05 - Meat Loaf - I'd Lie For You (And That's The Truth).mp3","trackType":"mp3"} Apr 07 09:30:14 volumio volumio[948]: verbose: CURRENT POSITION 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:14 volumio volumio[948]: info: No code Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: 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} Apr 07 09:30:14 volumio volumio[948]: verbose: CURRENT POSITION 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:14 volumio volumio[948]: info: No code Apr 07 09:30:14 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:14 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:14 volumio volumio[948]: info: ------------------------------ 47ms Apr 07 09:30:14 volumio volumio[948]: info: ------------------------------ 44ms Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:14 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:14 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 07 09:30:14 volumio volumio[948]: error: updateQueue error: null Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:14 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:14 volumio volumio[948]: info: ------------------------------ 42ms Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3" took 39 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: ------------------------------ 8ms Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:14 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:14 volumio volumio[948]: info: ------------------------------ 45ms Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand play took 44 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:14 volumio volumio[948]: info: ------------------------------ 25ms Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand status took 19 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand status took 19 milliseconds Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand status took 18 milliseconds Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:14 volumio volumio[948]: info: Apr 07 09:30:14 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:14 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:14 volumio volumio[948]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 07 09:30:15 volumio volumio[948]: info: sendMpdCommand status took 13 milliseconds Apr 07 09:30:15 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:15 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:15 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:15 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":309,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wind of Change","artist":"Scorpions","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3","trackType":"mp3"} Apr 07 09:30:15 volumio volumio[948]: verbose: CURRENT POSITION 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:15 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":309,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wind of Change","artist":"Scorpions","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3","trackType":"mp3"} Apr 07 09:30:15 volumio volumio[948]: verbose: CURRENT POSITION 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:15 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:15 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":309,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wind of Change","artist":"Scorpions","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3","trackType":"mp3"} Apr 07 09:30:15 volumio volumio[948]: verbose: CURRENT POSITION 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:15 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:15 volumio volumio[948]: info: ------------------------------ 49ms Apr 07 09:30:15 volumio volumio[948]: info: ------------------------------ 61ms Apr 07 09:30:15 volumio volumio[948]: info: ------------------------------ 60ms Apr 07 09:30:15 volumio volumio[948]: info: sendMpdCommand playlistinfo took 39 milliseconds Apr 07 09:30:15 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:15 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":228,"duration":309,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Wind of Change","artist":"Scorpions","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3","trackType":"mp3"} Apr 07 09:30:15 volumio volumio[948]: verbose: CURRENT POSITION 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:15 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:15 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:15 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:15 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:15 volumio volumio[948]: info: ------------------------------ 76ms Apr 07 09:30:15 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioNext Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::next Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::serviceStop Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 5 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::serviceStop Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::stop Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand stop took 42 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::play index undefined Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::clearAddPlayTracks USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/07 - Extreme - More Than Words.mp3 Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand status took 10 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand stop took 10 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand status took 9 milliseconds Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:16 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand clear took 2 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/07 - Extreme - More Than Words.mp3" Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: 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":"Wind of Change","artist":"Scorpions","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/06 - Scorpions - Wind of Change.mp3","trackType":"mp3"} Apr 07 09:30:16 volumio volumio[948]: verbose: CURRENT POSITION 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState stateService stop Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: No code Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 35ms Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 34ms Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:16 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:16 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 07 09:30:16 volumio volumio[948]: error: updateQueue error: null Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:16 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 29ms Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand add "USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/07 - Extreme - More Than Words.mp3" took 29 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 6ms Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces system playlist update Apr 07 09:30:16 volumio volumio[948]: info: Ignoring MPD Status Update Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 34ms Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand play took 29 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 28ms Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand status took 13 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand status took 13 milliseconds Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:16 volumio volumio[948]: info: Apr 07 09:30:16 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::getState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand status took 18 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand status took 11 milliseconds Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseState Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"More Than Words","artist":"Extreme","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/07 - Extreme - More Than Words.mp3","trackType":"mp3"} Apr 07 09:30:16 volumio volumio[948]: verbose: CURRENT POSITION 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"More Than Words","artist":"Extreme","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/07 - Extreme - More Than Words.mp3","trackType":"mp3"} Apr 07 09:30:16 volumio volumio[948]: verbose: CURRENT POSITION 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:16 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 54ms Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 59ms Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand playlistinfo took 30 milliseconds Apr 07 09:30:16 volumio volumio[948]: info: sendMpdCommand playlistinfo took 27 milliseconds Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:16 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":205,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"More Than Words","artist":"Extreme","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/07 - Extreme - More Than Words.mp3","trackType":"mp3"} Apr 07 09:30:16 volumio volumio[948]: verbose: CURRENT POSITION 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:16 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: ControllerMpd::pushState Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::servicePushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":285,"duration":261,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"More Than Words","artist":"Extreme","album":"Fantastic 90s","uri":"USB/Seagate_Expansion_Drive/МУЗЫКА/CD3/07 - Extreme - More Than Words.mp3","trackType":"mp3"} Apr 07 09:30:16 volumio volumio[948]: verbose: CURRENT POSITION 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState stateService play Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play Apr 07 09:30:16 volumio volumio[948]: info: Received an update from plugin. extracting info from payload Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:30:16 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:30:16 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 96ms Apr 07 09:30:16 volumio volumio[948]: info: ------------------------------ 88ms Apr 07 09:30:17 volumio volumio[948]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 07 09:30:26 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 07 09:30:26 volumio volumio[948]: info: CURURI: music-library Apr 07 09:30:26 volumio volumio[948]: info: Preload queue cleared Apr 07 09:30:27 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 07 09:30:27 volumio volumio[948]: info: CURURI: music-library/USB Apr 07 09:30:27 volumio volumio[948]: info: Preload queue cleared Apr 07 09:30:28 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 07 09:30:28 volumio volumio[948]: info: CURURI: music-library/USB/Seagate_Expansion_Drive Apr 07 09:30:28 volumio volumio[948]: info: Preload queue cleared Apr 07 09:30:29 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 07 09:30:29 volumio volumio[948]: info: CURURI: music-library/USB/Seagate_Expansion_Drive/МУЗЫКА Apr 07 09:30:29 volumio volumio[948]: info: Preload queue cleared Apr 07 09:30:44 volumio volumio[948]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Total Clients: 16 Apr 07 09:30:44 volumio volumio[948]: info: CoreCommandRouter::volumioGetState Apr 07 09:30:44 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:31:01 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 07 09:31:01 volumio volumio[948]: info: CURURI: music-library/USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless) Apr 07 09:31:01 volumio volumio[948]: error: Cue Parser - Cannot parse USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless)/03. Smokie – Легенды Зарубежного Рока (1999).cue Apr 07 09:31:01 volumio volumio[948]: info: Preload queue cleared Apr 07 09:31:05 volumio volumio[948]: info: Preload queue cleared Apr 07 09:31:05 volumio volumio[948]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::ClearQueue Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::stop Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock Apr 07 09:31:05 volumio volumio[948]: info: CorePlayQueue::getTrackBlock Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::pushState Apr 07 09:31:05 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:31:05 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 07 09:31:05 volumio volumio[948]: info: CoreCommandRouter::volumioPushState Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::serviceStop Apr 07 09:31:05 volumio volumio[948]: info: CorePlayQueue::getTrack 6 Apr 07 09:31:05 volumio volumio[948]: info: CoreCommandRouter::serviceStop Apr 07 09:31:05 volumio volumio[948]: info: ControllerMpd::stop Apr 07 09:31:05 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop Apr 07 09:31:05 volumio volumio[948]: info: CorePlayQueue::clearPlayQueue Apr 07 09:31:05 volumio volumio[948]: info: CorePlayQueue::saveQueue Apr 07 09:31:05 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue Apr 07 09:31:05 volumio volumio[948]: info: CoreStateMachine::addQueueItems Apr 07 09:31:05 volumio volumio[948]: info: CorePlayQueue::addQueueItems Apr 07 09:31:05 volumio volumio[948]: info: Preload queue cleared Apr 07 09:31:05 volumio volumio[948]: info: Adding Item to queue: music-library/USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless) Apr 07 09:31:05 volumio volumio[948]: info: Exploding uri music-library/USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless) in service mpd Apr 07 09:31:05 volumio volumio[948]: info: Apr 07 09:31:05 volumio volumio[948]: ---------------------------- MPD announces state update: player Apr 07 09:31:05 volumio volumio[948]: info: ALBUMART /albumart?cacheid=733&web=//extralarge&path=%2Fmnt%2FUSB%2FSeagate_Expansion_Drive%2F%D0%9C%D0%A3%D0%97%D0%AB%D0%9A%D0%90%2FSmokie%20%E2%80%93%20%D0%9B%D0%B5%D0%B3%D0%B5%D0%BD%D0%B4%D1%8B%20%D0%97%D0%B0%D1%80%D1%83%D0%B1%D0%B5%D0%B6%D0%BD%D0%BE%D0%B3%D0%BE%20%D0%A0%D0%BE%D0%BA%D0%B0%20%5BMC%5D%20-%201999%20(lossless)%2F01.%20Side%20A.flac&metadata=false Apr 07 09:31:05 volumio volumio[948]: info: URI /mnt/USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless)/01. Side A.flac Apr 07 09:31:05 volumio volumio[948]: info: ALBUMART /albumart?cacheid=733&web=//extralarge&path=%2Fmnt%2FUSB%2FSeagate_Expansion_Drive%2F%D0%9C%D0%A3%D0%97%D0%AB%D0%9A%D0%90%2FSmokie%20%E2%80%93%20%D0%9B%D0%B5%D0%B3%D0%B5%D0%BD%D0%B4%D1%8B%20%D0%97%D0%B0%D1%80%D1%83%D0%B1%D0%B5%D0%B6%D0%BD%D0%BE%D0%B3%D0%BE%20%D0%A0%D0%BE%D0%BA%D0%B0%20%5BMC%5D%20-%201999%20(lossless)%2F02.%20Side%20B.flac&metadata=false Apr 07 09:31:05 volumio volumio[948]: info: URI /mnt/USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless)/02. Side B.flac Apr 07 09:31:05 volumio volumio[948]: info: ALBUMART /albumart?cacheid=733&web=/%3F%3F%3F%3F%3F%3F%3F%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%20%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Expansion_Drive%2F%D0%9C%D0%A3%D0%97%D0%AB%D0%9A%D0%90%2FSmokie%20%E2%80%93%20%D0%9B%D0%B5%D0%B3%D0%B5%D0%BD%D0%B4%D1%8B%20%D0%97%D0%B0%D1%80%D1%83%D0%B1%D0%B5%D0%B6%D0%BD%D0%BE%D0%B3%D0%BE%20%D0%A0%D0%BE%D0%BA%D0%B0%20%5BMC%5D%20-%201999%20(lossless)%2F03.%20Smokie%20%E2%80%93%20%D0%9B%D0%B5%D0%B3%D0%B5%D0%BD%D0%B4%D1%8B%20%D0%97%D0%B0%D1%80%D1%83%D0%B1%D0%B5%D0%B6%D0%BD%D0%BE%D0%B3%D0%BE%20%D0%A0%D0%BE%D0%BA%D0%B0%20(1999).cue&metadata=false Apr 07 09:31:05 volumio volumio[948]: info: URI /mnt/USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless)/03. Smokie – Легенды Зарубежного Рока (1999).cue Apr 07 09:31:05 volumio volumio[948]: info: ALBUMART /albumart?cacheid=733&web=/%3F%3F%3F%3F%3F%3F%3F%20%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%3F%20%3F%3F%3F%3F/extralarge&path=%2Fmnt%2FUSB%2FSeagate_Expansion_Drive%2F%D0%9C%D0%A3%D0%97%D0%AB%D0%9A%D0%90%2FSmokie%20%E2%80%93%20%D0%9B%D0%B5%D0%B3%D0%B5%D0%BD%D0%B4%D1%8B%20%D0%97%D0%B0%D1%80%D1%83%D0%B1%D0%B5%D0%B6%D0%BD%D0%BE%D0%B3%D0%BE%20%D0%A0%D0%BE%D0%BA%D0%B0%20%5BMC%5D%20-%201999%20(lossless)%2F03.%20Smokie%20%E2%80%93%20%D0%9B%D0%B5%D0%B3%D0%B5%D0%BD%D0%B4%D1%8B%20%D0%97%D0%B0%D1%80%D1%83%D0%B1%D0%B5%D0%B6%D0%BD%D0%BE%D0%B3%D0%BE%20%D0%A0%D0%BE%D0%BA%D0%B0%20(1999).cue&metadata=false Apr 07 09:31:05 volumio volumio[948]: info: URI /mnt/USB/Seagate_Expansion_Drive/МУЗЫКА/Smokie – Легенды Зарубежного Рока [MC] - 1999 (lossless)/03. Smokie – Легенды Зарубежного Рока (1999).cue Apr 07 09:31:05 volumio volumio[948]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 09:31:05 volumio volumio[948]: Error: Unable to resolve or reject the same promise twice Apr 07 09:31:05 volumio volumio[948]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Apr 07 09:31:05 volumio volumio[948]: at /volumio/app/plugins/music_service/mpd/index.js:2568:21 Apr 07 09:31:05 volumio volumio[948]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Apr 07 09:31:05 volumio volumio[948]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Apr 07 09:31:05 volumio volumio[948]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Apr 07 09:31:05 volumio volumio[948]: at Socket.emit (events.js:315:20) Apr 07 09:31:05 volumio volumio[948]: at addChunk (internal/streams/readable.js:309:12) Apr 07 09:31:05 volumio volumio[948]: at readableAddChunk (internal/streams/readable.js:280:11) Apr 07 09:31:05 volumio volumio[948]: at Socket.Readable.push (internal/streams/readable.js:223:10) Apr 07 09:31:05 volumio volumio[948]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Apr 07 09:31:05 volumio volumio[948]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 07 09:31:05 volumio sudo[3644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-07 09:30 Apr 07 09:31:05 volumio sudo[3644]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"