-- Logs begin at Sun 2025-03-02 16:45:48 MSK, end at Sun 2025-03-16 13:05:43 MSK. -- Mar 16 13:04:00 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Mar 16 13:04:00 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Mar 16 13:04:00 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Mar 16 13:04:02 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Mar 16 13:04:07 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Mar 16 13:04:07 volumio volumio[1150]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Mar 16 13:04:07 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Mar 16 13:04:07 volumio volumio[1150]: info: Received Get System Version Mar 16 13:04:07 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 13:04:07 volumio volumio[1150]: info: Received Get System Info Mar 16 13:04:07 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 13:04:07 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 13:04:07 volumio volumio[1150]: info: Discovery: Getting this device information Mar 16 13:04:07 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Mar 16 13:04:07 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:07 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 13:04:08 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 16 13:04:08 volumio volumio[1150]: info: Received Get System Info Mar 16 13:04:08 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 13:04:08 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 13:04:08 volumio volumio[1150]: info: Discovery: Getting this device information Mar 16 13:04:08 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Mar 16 13:04:08 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:08 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 13:04:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPlay Mar 16 13:04:10 volumio volumio[1150]: info: CoreStateMachine::play index undefined Mar 16 13:04:10 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:10 volumio volumio[1150]: info: CoreStateMachine::startPlaybackTimer Mar 16 13:04:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:04:10 volumio volumio[1150]: info: sendMpdCommand stop took 2 milliseconds Mar 16 13:04:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand clear Mar 16 13:04:10 volumio volumio[1150]: info: Mar 16 13:04:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:10 volumio volumio[1150]: info: sendMpdCommand clear took 3 milliseconds Mar 16 13:04:10 volumio volumio[1150]: info: Mar 16 13:04:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:10 volumio volumio[1150]: info: Mar 16 13:04:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:10 volumio volumio[1150]: info: Mar 16 13:04:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:10 volumio volumio[1150]: info: ------------------------------ 12ms Mar 16 13:04:10 volumio volumio[1150]: info: ------------------------------ 5ms Mar 16 13:04:10 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:10 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:10 volumio volumio[1150]: error: Upnp client error: Error: This socket has been ended by the other party Mar 16 13:04:11 volumio volumio[1150]: info: CoreCommandRouter::volumioPlay Mar 16 13:04:11 volumio volumio[1150]: info: CoreStateMachine::play index undefined Mar 16 13:04:11 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:11 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:11 volumio volumio[1150]: info: CoreStateMachine::startPlaybackTimer Mar 16 13:04:11 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:11 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:04:11 volumio volumio[1150]: info: sendMpdCommand stop took 1 milliseconds Mar 16 13:04:11 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand clear Mar 16 13:04:11 volumio volumio[1150]: info: Mar 16 13:04:11 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:11 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:11 volumio volumio[1150]: info: sendMpdCommand clear took 2 milliseconds Mar 16 13:04:11 volumio volumio[1150]: info: Mar 16 13:04:11 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:11 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:11 volumio volumio[1150]: info: Mar 16 13:04:11 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:11 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:11 volumio volumio[1150]: info: Mar 16 13:04:11 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:11 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:11 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:11 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:11 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:11 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:11 volumio volumio[1150]: info: ------------------------------ 9ms Mar 16 13:04:11 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:11 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:11 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:11 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:11 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:11 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:11 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:11 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:13 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3" Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3" took 2 milliseconds Mar 16 13:04:13 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:13 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:13 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 9ms Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 6ms Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 5ms Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:13 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:04:13 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand play Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: Mar 16 13:04:13 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:13 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 7ms Mar 16 13:04:13 volumio volumio[1150]: info: sendMpdCommand play took 6 milliseconds Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 5ms Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:13 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:04:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 16 13:04:13 volumio volumio[1150]: info: Received Get System Info Mar 16 13:04:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 13:04:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 13:04:13 volumio volumio[1150]: info: Discovery: Getting this device information Mar 16 13:04:13 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Mar 16 13:04:13 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 13:04:14 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3" Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3" took 2 milliseconds Mar 16 13:04:14 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:14 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:14 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 6ms Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:14 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:04:14 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand play Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: Mar 16 13:04:14 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:14 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 5ms Mar 16 13:04:14 volumio volumio[1150]: info: sendMpdCommand play took 4 milliseconds Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:14 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 16 13:04:16 volumio volumio[1150]: info: Received Get System Info Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 13:04:16 volumio volumio[1150]: info: Discovery: Getting this device information Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 24 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 23 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 21 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 20 milliseconds Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: Mar 16 13:04:16 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 12 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 7 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 5 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand status took 4 milliseconds Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus stop Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":445,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:16 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":445,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:16 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":445,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:16 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 71ms Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 106ms Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 105ms Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 104ms Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 70 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 67 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 67 milliseconds Mar 16 13:04:16 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 67 milliseconds Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:16 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:16 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:16 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:16 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":218,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Грустный эконом","artist":"PIZZA","album":"Грустный эконом","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbb8bddec3db508c6e7cb250060b6624be8cd664b4c5f884431ad121ce6ba70ca%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46f8c%2F0%2F1756040%2Fb09d84db.200688901.9.136687723%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:16 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:16 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 205ms Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 199ms Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 198ms Mar 16 13:04:16 volumio volumio[1150]: info: ------------------------------ 198ms Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:16 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:16 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:17 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:17 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:17 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:17 volumio volumio[1150]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 16 13:04:18 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri Mar 16 13:04:19 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/2215098:5698895@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/45289549:6080014@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/48591706:4277134@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/36664872:4620359@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/31477411:3815602@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/28036316:7823127@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/45130892:6055011@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/38633715:5307396@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/37615:10624581@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/126808267:31560444@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/62208587:18410644@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/113847117:25864974@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/130775748:33148238@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/2774888:298151@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/131275894:33347583@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/128824645:32407305@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/733940:81702@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/27374238:3277402@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/117899972:27609887@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/40837812:25371810@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/834019:22049051@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/39257491:5060852@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/28192829:3369432@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/23856627:3034548@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/6006252:660238@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/26219949:3113823@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/34568042:11277@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/114053361:25954615@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/9573679:1014842@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/71777559:12270283@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/700001:17603143@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/123243660:30001312@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/17297:2501088@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/129313331:32551353@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/29569939:3558237@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/127443182:31815340@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/46197:3791@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/68348389:11322908@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/28061214:101535@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/18079544:2003176@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/25481923:3007165@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/26141465:3103987@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/57104680:10871209@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/76154361:33999235@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/123179368:29969955@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/24745650:2897427@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/4368386:496044@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/1490926:151727@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/3460921:369724@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/67458050:11087387@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/64357979:10329735@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/17887609:22517447@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/67469457:11091035@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/49286341:6759507@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/125739644:31120608@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/3962382:446019@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/2841625:3935337@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/63793003:10181414@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/108039579:23775970@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Preloading song: yandex_music/track/240837:13084662@503646255:24576982 Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/2215098:5698895@503646255:24576982 in service yandex_music Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/45289549:6080014@503646255:24576982 in service yandex_music Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/48591706:4277134@503646255:24576982 in service yandex_music Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/36664872:4620359@503646255:24576982 in service yandex_music Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/31477411:3815602@503646255:24576982 in service yandex_music Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/28036316:7823127@503646255:24576982 in service yandex_music Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/45130892:6055011@503646255:24576982 in service yandex_music Mar 16 13:04:19 volumio volumio[1150]: info: Exploding uri yandex_music/track/38633715:5307396@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/37615:10624581@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/126808267:31560444@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/62208587:18410644@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/113847117:25864974@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/130775748:33148238@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/2774888:298151@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/131275894:33347583@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/128824645:32407305@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/733940:81702@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/27374238:3277402@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/117899972:27609887@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/40837812:25371810@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/834019:22049051@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/39257491:5060852@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/28192829:3369432@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/23856627:3034548@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/6006252:660238@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/26219949:3113823@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/34568042:11277@503646255:24576982 in service yandex_music Mar 16 13:04:20 volumio volumio[1150]: info: Exploding uri yandex_music/track/114053361:25954615@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/9573679:1014842@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/71777559:12270283@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/700001:17603143@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/123243660:30001312@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/17297:2501088@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/129313331:32551353@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/29569939:3558237@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/127443182:31815340@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/46197:3791@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/68348389:11322908@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/28061214:101535@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/18079544:2003176@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/25481923:3007165@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/26141465:3103987@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/57104680:10871209@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/76154361:33999235@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/123179368:29969955@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/24745650:2897427@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/4368386:496044@503646255:24576982 in service yandex_music Mar 16 13:04:21 volumio volumio[1150]: info: Exploding uri yandex_music/track/1490926:151727@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/3460921:369724@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/67458050:11087387@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/64357979:10329735@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/17887609:22517447@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/67469457:11091035@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/49286341:6759507@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/125739644:31120608@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/3962382:446019@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/2841625:3935337@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/63793003:10181414@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/108039579:23775970@503646255:24576982 in service yandex_music Mar 16 13:04:22 volumio volumio[1150]: info: Exploding uri yandex_music/track/240837:13084662@503646255:24576982 in service yandex_music Mar 16 13:04:37 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::ClearQueue Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::stop Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::stPlaybackTimer Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::updateTrackBlock Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrackBlock Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::serviceStop Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::serviceStop Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::stop Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::clearPlayQueue Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::saveQueue Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioPushQueue Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::addQueueItems Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::addQueueItems Mar 16 13:04:37 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/2215098:5698895@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/2215098:5698895@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/45289549:6080014@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/45289549:6080014@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/48591706:4277134@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/48591706:4277134@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/36664872:4620359@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/36664872:4620359@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/31477411:3815602@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/31477411:3815602@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/28036316:7823127@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/28036316:7823127@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/45130892:6055011@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/45130892:6055011@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/38633715:5307396@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/38633715:5307396@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/37615:10624581@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/37615:10624581@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/126808267:31560444@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/126808267:31560444@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/62208587:18410644@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/62208587:18410644@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/113847117:25864974@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/113847117:25864974@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/130775748:33148238@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/130775748:33148238@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/2774888:298151@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/2774888:298151@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/131275894:33347583@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/131275894:33347583@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/128824645:32407305@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/128824645:32407305@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/733940:81702@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/733940:81702@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/27374238:3277402@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/27374238:3277402@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/117899972:27609887@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/117899972:27609887@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/40837812:25371810@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/40837812:25371810@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/834019:22049051@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/834019:22049051@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/39257491:5060852@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/39257491:5060852@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/28192829:3369432@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/28192829:3369432@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/23856627:3034548@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/23856627:3034548@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/6006252:660238@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/6006252:660238@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/26219949:3113823@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/26219949:3113823@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/34568042:11277@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/34568042:11277@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/114053361:25954615@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/114053361:25954615@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/9573679:1014842@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/9573679:1014842@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/71777559:12270283@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/71777559:12270283@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/700001:17603143@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/700001:17603143@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/123243660:30001312@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/123243660:30001312@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/17297:2501088@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/17297:2501088@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/129313331:32551353@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/129313331:32551353@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/29569939:3558237@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/29569939:3558237@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/127443182:31815340@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/127443182:31815340@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/46197:3791@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/46197:3791@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/68348389:11322908@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/68348389:11322908@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/28061214:101535@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/28061214:101535@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/18079544:2003176@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/18079544:2003176@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/25481923:3007165@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/25481923:3007165@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/26141465:3103987@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/26141465:3103987@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/57104680:10871209@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/57104680:10871209@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/76154361:33999235@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/76154361:33999235@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/123179368:29969955@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/123179368:29969955@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/24745650:2897427@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/24745650:2897427@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/4368386:496044@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/4368386:496044@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/1490926:151727@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/1490926:151727@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/3460921:369724@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/3460921:369724@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/67458050:11087387@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/67458050:11087387@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/64357979:10329735@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/64357979:10329735@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/17887609:22517447@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/17887609:22517447@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/67469457:11091035@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/67469457:11091035@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/49286341:6759507@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/49286341:6759507@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/125739644:31120608@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/125739644:31120608@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/3962382:446019@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/3962382:446019@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/2841625:3935337@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/2841625:3935337@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/63793003:10181414@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/63793003:10181414@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/108039579:23775970@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/108039579:23775970@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/240837:13084662@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: Using cached record of: yandex_music/track/240837:13084662@503646255:24576982 Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioPushQueue Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::saveQueue Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::updateTrackBlock Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrackBlock Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioPlay Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::play index 21 Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::stop Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::play index undefined Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::startPlaybackTimer Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand stop took 138 milliseconds Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand stop took 40 milliseconds Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand clear Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand status took 55 milliseconds Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand clear took 46 milliseconds Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand status took 41 milliseconds Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand status took 40 milliseconds Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand status took 40 milliseconds Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:04:37 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:37 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:37 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 80ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 80ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 79ms Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:37 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:37 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:37 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 69ms Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 65 milliseconds Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 21ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 20ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 19ms Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:37 volumio volumio[1150]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 127ms Mar 16 13:04:37 volumio volumio[1150]: info: touch_display: Setting screensaver timeout to 3600 seconds. Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3" Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3" took 4 milliseconds Mar 16 13:04:37 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:37 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:37 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 9ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 6ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:37 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:04:37 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand play Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: Mar 16 13:04:37 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:37 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 7ms Mar 16 13:04:37 volumio volumio[1150]: info: sendMpdCommand play took 5 milliseconds Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:37 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 13 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 13 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 12 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 10 milliseconds Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: Mar 16 13:04:39 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 33 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 31 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 30 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 23 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand status took 21 milliseconds Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus stop Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:39 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:39 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:39 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 107ms Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 150ms Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 149ms Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 149ms Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 106 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 105 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 105 milliseconds Mar 16 13:04:39 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 105 milliseconds Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:39 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:39 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:39 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:39 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:39 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":215,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"А зори здесь тихие-тихие","artist":"Любэ","album":"Лучшие песни. Часть 3","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Daaab8f78cca2e7ce7215afd36f7d2827b478e1b9b8633786a534d04226cc67a5%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e46383%2F0%2F478620%2F6243ddd3.59221681.9.39257491%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 16 13:04:39 volumio volumio[1150]: verbose: CURRENT POSITION 21 Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:39 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:39 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 267ms Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 263ms Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 263ms Mar 16 13:04:39 volumio volumio[1150]: info: ------------------------------ 256ms Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:40 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:40 volumio volumio[1150]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 16 13:04:42 volumio volumio[1150]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Mar 16 13:04:42 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Mar 16 13:04:44 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::ClearQueue Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::stop Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::stPlaybackTimer Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::updateTrackBlock Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrackBlock Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::serviceStop Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 21 Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::serviceStop Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::stop Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::clearPlayQueue Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::saveQueue Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioPushQueue Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::addQueueItems Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::addQueueItems Mar 16 13:04:44 volumio volumio[1150]: info: Preload queue cleared Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/2215098:5698895@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/2215098:5698895@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/45289549:6080014@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/45289549:6080014@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/48591706:4277134@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/48591706:4277134@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/36664872:4620359@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/36664872:4620359@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/31477411:3815602@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/31477411:3815602@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/28036316:7823127@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/28036316:7823127@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/45130892:6055011@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/45130892:6055011@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/38633715:5307396@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/38633715:5307396@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/37615:10624581@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/37615:10624581@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/126808267:31560444@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/126808267:31560444@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/62208587:18410644@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/62208587:18410644@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/113847117:25864974@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/113847117:25864974@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/130775748:33148238@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/130775748:33148238@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/2774888:298151@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/2774888:298151@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/131275894:33347583@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/131275894:33347583@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/128824645:32407305@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/128824645:32407305@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/733940:81702@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/733940:81702@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/27374238:3277402@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/27374238:3277402@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/117899972:27609887@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/117899972:27609887@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/40837812:25371810@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/40837812:25371810@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/834019:22049051@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/834019:22049051@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/39257491:5060852@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/39257491:5060852@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/28192829:3369432@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/28192829:3369432@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/23856627:3034548@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/23856627:3034548@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/6006252:660238@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/6006252:660238@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/26219949:3113823@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/26219949:3113823@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/34568042:11277@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/34568042:11277@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/114053361:25954615@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/114053361:25954615@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/9573679:1014842@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/9573679:1014842@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/71777559:12270283@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/71777559:12270283@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/700001:17603143@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/700001:17603143@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/123243660:30001312@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/123243660:30001312@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/17297:2501088@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/17297:2501088@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/129313331:32551353@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/129313331:32551353@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/29569939:3558237@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/29569939:3558237@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/127443182:31815340@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/127443182:31815340@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/46197:3791@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/46197:3791@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/68348389:11322908@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/68348389:11322908@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/28061214:101535@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/28061214:101535@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/18079544:2003176@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/18079544:2003176@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/25481923:3007165@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/25481923:3007165@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/26141465:3103987@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/26141465:3103987@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/57104680:10871209@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/57104680:10871209@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/76154361:33999235@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/76154361:33999235@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/123179368:29969955@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/123179368:29969955@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/24745650:2897427@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/24745650:2897427@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/4368386:496044@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/4368386:496044@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/1490926:151727@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/1490926:151727@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/3460921:369724@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/3460921:369724@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/67458050:11087387@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/67458050:11087387@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/64357979:10329735@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/64357979:10329735@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/17887609:22517447@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/17887609:22517447@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/67469457:11091035@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/67469457:11091035@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/49286341:6759507@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/49286341:6759507@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/125739644:31120608@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/125739644:31120608@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/3962382:446019@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/3962382:446019@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/2841625:3935337@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/2841625:3935337@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/63793003:10181414@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/63793003:10181414@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/108039579:23775970@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/108039579:23775970@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Adding Item to queue: yandex_music/track/240837:13084662@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: Using cached record of: yandex_music/track/240837:13084662@503646255:24576982 Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioPushQueue Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::saveQueue Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::updateTrackBlock Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrackBlock Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioPlay Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::play index 0 Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::stop Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::play index undefined Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::startPlaybackTimer Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand stop took 98 milliseconds Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand stop took 26 milliseconds Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand clear Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:44 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand status took 47 milliseconds Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand clear took 46 milliseconds Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand status took 44 milliseconds Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand status took 42 milliseconds Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand status took 41 milliseconds Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:04:44 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:44 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:44 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:44 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 95ms Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 93ms Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 91ms Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:44 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:44 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:44 volumio volumio[1150]: info: Mar 16 13:04:44 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:44 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:44 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:44 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:44 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:44 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 77ms Mar 16 13:04:44 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 73 milliseconds Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 16ms Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 15ms Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 14ms Mar 16 13:04:44 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:44 volumio volumio[1150]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 16 13:04:44 volumio volumio[1150]: info: ------------------------------ 134ms Mar 16 13:04:44 volumio volumio[1150]: info: touch_display: Setting screensaver timeout to 3600 seconds. Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac" Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac" took 2 milliseconds Mar 16 13:04:45 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:45 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:45 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 6ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand play Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:04:45 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 7ms Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand play took 7 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 6ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 5ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 4 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 4 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 3 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 2 milliseconds Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: Mar 16 13:04:45 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 6 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 4 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 3 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand status took 3 milliseconds Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus stop Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:45 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:45 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:45 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 47ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 98ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 98ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 97ms Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 90 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 89 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 88 milliseconds Mar 16 13:04:45 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 88 milliseconds Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:45 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:45 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:45 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:04:45 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Позови меня тихо по имени","artist":"Любэ","album":"Николай Расторгуев. 55","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D129bc727ab4f415573f8a2a3d8e5edf07539fe2076e429214af9e49f449a60b6%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4fbb5%2F0%2F13456474%2Fa6df23ba.182223841.14.2215098%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:04:45 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:04:45 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 210ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 207ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 207ms Mar 16 13:04:45 volumio volumio[1150]: info: ------------------------------ 208ms Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:04:45 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:04:45 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:04:46 volumio volumio[1150]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 16 13:04:47 volumio volumio[1150]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Mar 16 13:04:47 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioNext Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::next Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::next Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand next Mar 16 13:05:10 volumio volumio[1150]: info: sendMpdCommand next took 49 milliseconds Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:10 volumio volumio[1150]: info: sendMpdCommand status took 4 milliseconds Mar 16 13:05:10 volumio volumio[1150]: info: sendMpdCommand status took 3 milliseconds Mar 16 13:05:10 volumio volumio[1150]: info: sendMpdCommand status took 2 milliseconds Mar 16 13:05:10 volumio volumio[1150]: info: sendMpdCommand status took 2 milliseconds Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 0 Mar 16 13:05:10 volumio volumio[1150]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 16 13:05:10 volumio volumio[1150]: verbose: CURRENT POSITION 0 Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::syncState stateService stop Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::play index undefined Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:05:10 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::startPlaybackTimer Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 77ms Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 77ms Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 77ms Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 76ms Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:10 volumio volumio[1150]: info: sendMpdCommand stop took 22 milliseconds Mar 16 13:05:10 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand clear Mar 16 13:05:10 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:10 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:10 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:10 volumio volumio[1150]: info: sendMpdCommand clear took 52 milliseconds Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:10 volumio volumio[1150]: info: Mar 16 13:05:10 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:10 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:10 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 48ms Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 34ms Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 33ms Mar 16 13:05:10 volumio volumio[1150]: info: ------------------------------ 32ms Mar 16 13:05:10 volumio volumio[1150]: info: touch_display: Setting screensaver timeout to 3600 seconds. Mar 16 13:05:19 volumio volumio[1150]: info: CoreCommandRouter::volumioPlay Mar 16 13:05:19 volumio volumio[1150]: info: CoreStateMachine::play index undefined Mar 16 13:05:19 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 13:05:19 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:19 volumio volumio[1150]: info: CoreStateMachine::startPlaybackTimer Mar 16 13:05:19 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:19 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 13:05:19 volumio volumio[1150]: info: sendMpdCommand stop took 1 milliseconds Mar 16 13:05:19 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand clear Mar 16 13:05:19 volumio volumio[1150]: info: sendMpdCommand clear took 0 milliseconds Mar 16 13:05:19 volumio volumio[1150]: info: Mar 16 13:05:19 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:19 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:19 volumio volumio[1150]: info: Mar 16 13:05:19 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:19 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:19 volumio volumio[1150]: info: Mar 16 13:05:19 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:19 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:19 volumio volumio[1150]: info: Mar 16 13:05:19 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:19 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:19 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:19 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:19 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:19 volumio volumio[1150]: error: updateQueue error: null Mar 16 13:05:19 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:05:19 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:05:19 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:05:19 volumio volumio[1150]: info: ------------------------------ 1ms Mar 16 13:05:21 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac" Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac" took 1 milliseconds Mar 16 13:05:21 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:05:21 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:05:21 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:05:21 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:05:21 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand play Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 5ms Mar 16 13:05:21 volumio volumio[1150]: info: sendMpdCommand play took 4 milliseconds Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 1ms Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: Mar 16 13:05:21 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:21 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:05:21 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:05:22 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac" Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac" took 3 milliseconds Mar 16 13:05:22 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:05:22 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:05:22 volumio volumio[1150]: verbose: MPD COMMAND [object Object] Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 8ms Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 6ms Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 4ms Mar 16 13:05:22 volumio volumio[1150]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 16 13:05:22 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand play Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: Mar 16 13:05:22 volumio volumio[1150]: ---------------------------- MPD announces system playlist update Mar 16 13:05:22 volumio volumio[1150]: info: Ignoring MPD Status Update Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 5ms Mar 16 13:05:22 volumio volumio[1150]: info: sendMpdCommand play took 3 milliseconds Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 3ms Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 2ms Mar 16 13:05:22 volumio volumio[1150]: info: ------------------------------ 1ms Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 6 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 6 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 6 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 5 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 2 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus stop Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 13ms Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: info: Mar 16 13:05:23 volumio volumio[1150]: ---------------------------- MPD announces state update: player Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::getState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand status Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 4 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 3 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand status took 2 milliseconds Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseState Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:23 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:23 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:23 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:23 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 113ms Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 113ms Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 113ms Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 113ms Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 100 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 101 milliseconds Mar 16 13:05:23 volumio volumio[1150]: info: sendMpdCommand playlistinfo took 100 milliseconds Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: verbose: ControllerMpd::parseTrackInfo Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:23 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:23 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: ControllerMpd::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::servicePushState Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getTrack 1 Mar 16 13:05:23 volumio volumio[1150]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Chi Maï","artist":"Ennio Morricone","album":"Made In France","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f24154e77f11dad026e5917dc606591df184b7c1d82cbe219d148a85edc641c%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e4f6b3%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 16 13:05:23 volumio volumio[1150]: verbose: CURRENT POSITION 1 Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState stateService play Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::syncState currentStatus play Mar 16 13:05:23 volumio volumio[1150]: info: Received an update from plugin. extracting info from payload Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::pushState Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioPushState Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 186ms Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 186ms Mar 16 13:05:23 volumio volumio[1150]: info: ------------------------------ 185ms Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreCommandRouter::volumioGetQueue Mar 16 13:05:23 volumio volumio[1150]: info: CoreStateMachine::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: CorePlayQueue::getQueue Mar 16 13:05:23 volumio volumio[1150]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 16 13:05:24 volumio volumio[1150]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Mar 16 13:05:24 volumio volumio[1150]: info: CoreCommandRouter::volumioGetState Mar 16 13:05:43 volumio volumio[1150]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 13:05:43 volumio volumio[1150]: Error: read ECONNRESET Mar 16 13:05:43 volumio volumio[1150]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Mar 16 13:05:43 volumio volumio[1150]: errno: -104, Mar 16 13:05:43 volumio volumio[1150]: code: 'ECONNRESET', Mar 16 13:05:43 volumio volumio[1150]: syscall: 'read' Mar 16 13:05:43 volumio volumio[1150]: } Mar 16 13:05:43 volumio volumio[1150]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 13:05:43 volumio sudo[5853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 13:04 Mar 16 13:05:43 volumio sudo[5853]: 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="51755a7ab41793587aa858aae43b662293a9df12" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 02 Jun 2024 06:06:05 PM CEST" VOLUMIO_VERSION="3.701" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe4d1e78c5ecc2059f504259e3e8eb08"