-- Logs begin at Sun 2025-03-09 17:27:40 MSK, end at Sun 2025-03-09 17:31:33 MSK. -- Mar 09 17:30:01 volumio volumio[1021]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Mar 09 17:30:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Mar 09 17:30:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 09 17:30:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 09 17:30:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 09 17:30:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 09 17:30:01 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 17:30:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:03 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:03 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:03 volumio volumio[1021]: info: sendMpdCommand next took 20 milliseconds Mar 09 17:30:03 volumio volumio[1021]: info: Mar 09 17:30:03 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:03 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:03 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:03 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:03 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:03 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:03 volumio volumio[1021]: info: CorePlayQueue::getTrack 9 Mar 09 17:30:03 volumio volumio[1021]: 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 09 17:30:03 volumio volumio[1021]: verbose: CURRENT POSITION 9 Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:03 volumio volumio[1021]: info: CorePlayQueue::getTrack 10 Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:03 volumio volumio[1021]: info: CorePlayQueue::getTrack 10 Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:03 volumio volumio[1021]: info: CorePlayQueue::getTrack 10 Mar 09 17:30:03 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:03 volumio volumio[1021]: info: ------------------------------ 8ms Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:03 volumio volumio[1021]: info: CorePlayQueue::getTrack 10 Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:03 volumio volumio[1021]: info: sendMpdCommand stop took 5 milliseconds Mar 09 17:30:03 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:03 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:03 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:03 volumio volumio[1021]: info: Mar 09 17:30:03 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:03 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:03 volumio volumio[1021]: info: sendMpdCommand clear took 4 milliseconds Mar 09 17:30:03 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:03 volumio volumio[1021]: info: ------------------------------ 2ms Mar 09 17:30:03 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6b8e952ef11e793f6ce9aa8f55aa5c2335ca564c5f757b2df61efd8bca14ac1e%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbbc33%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac" Mar 09 17:30:03 volumio volumio[1021]: info: Mar 09 17:30:03 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:03 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:03 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-62.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6b8e952ef11e793f6ce9aa8f55aa5c2335ca564c5f757b2df61efd8bca14ac1e%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbbc33%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac" took 0 milliseconds Mar 09 17:30:03 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:03 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:03 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:03 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:03 volumio volumio[1021]: info: Mar 09 17:30:03 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:03 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:03 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:03 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:03 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:03 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:04 volumio volumio[1021]: info: Mar 09 17:30:04 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:04 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:04 volumio volumio[1021]: info: Mar 09 17:30:04 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:04 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:30:04 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:04 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:04 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:04 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:04 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:04 volumio volumio[1021]: info: CorePlayQueue::getTrack 10 Mar 09 17:30:04 volumio volumio[1021]: 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%3D6b8e952ef11e793f6ce9aa8f55aa5c2335ca564c5f757b2df61efd8bca14ac1e%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbbc33%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:04 volumio volumio[1021]: verbose: CURRENT POSITION 10 Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:04 volumio volumio[1021]: info: ------------------------------ 4ms Mar 09 17:30:04 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:04 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:04 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:04 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:04 volumio volumio[1021]: info: CorePlayQueue::getTrack 10 Mar 09 17:30:04 volumio volumio[1021]: 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%3D6b8e952ef11e793f6ce9aa8f55aa5c2335ca564c5f757b2df61efd8bca14ac1e%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbbc33%2F0%2F224253%2F914c688c.67500257.13.45289549%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:04 volumio volumio[1021]: verbose: CURRENT POSITION 10 Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:04 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:04 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:04 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:04 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:04 volumio volumio[1021]: info: ------------------------------ 9ms Mar 09 17:30:04 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:04 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:04 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:04 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:04 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:06 volumio volumio[1021]: 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: 12 Mar 09 17:30:06 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:11 volumio sudo[2862]: pam_unix(sudo:session): session closed for user root Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:13 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand next took 18 milliseconds Mar 09 17:30:13 volumio volumio[1021]: info: Mar 09 17:30:13 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:13 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:13 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getTrack 10 Mar 09 17:30:13 volumio volumio[1021]: 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 09 17:30:13 volumio volumio[1021]: verbose: CURRENT POSITION 10 Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getTrack 11 Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getTrack 11 Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getTrack 11 Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:13 volumio volumio[1021]: info: ------------------------------ 5ms Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getTrack 11 Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand stop took 3 milliseconds Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:13 volumio volumio[1021]: info: Mar 09 17:30:13 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:13 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand clear took 4 milliseconds Mar 09 17:30:13 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:13 volumio volumio[1021]: info: ------------------------------ 2ms Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D135e576754b7d16f2825212161026e2f059862e63b6ff731596228838a5cf488%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db4069%2F24987%2F9873%2Fa19e12ae.2861426.4.2192826%2F320.mp3&ext=.mp3" Mar 09 17:30:13 volumio volumio[1021]: info: Mar 09 17:30:13 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:13 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D135e576754b7d16f2825212161026e2f059862e63b6ff731596228838a5cf488%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db4069%2F24987%2F9873%2Fa19e12ae.2861426.4.2192826%2F320.mp3&ext=.mp3" took 1 milliseconds Mar 09 17:30:13 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:13 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:13 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:13 volumio volumio[1021]: info: Mar 09 17:30:13 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:13 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:13 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:13 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand play took 1 milliseconds Mar 09 17:30:13 volumio volumio[1021]: info: Mar 09 17:30:13 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:13 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:13 volumio volumio[1021]: info: Mar 09 17:30:13 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand status took 3 milliseconds Mar 09 17:30:13 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:13 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getTrack 11 Mar 09 17:30:13 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":158,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Владивосток 2000","artist":"Мумий Тролль","album":"Best 20-20","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D135e576754b7d16f2825212161026e2f059862e63b6ff731596228838a5cf488%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db4069%2F24987%2F9873%2Fa19e12ae.2861426.4.2192826%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:13 volumio volumio[1021]: verbose: CURRENT POSITION 11 Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:13 volumio volumio[1021]: info: ------------------------------ 4ms Mar 09 17:30:13 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:13 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:13 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getTrack 11 Mar 09 17:30:13 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":885,"duration":158,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Владивосток 2000","artist":"Мумий Тролль","album":"Best 20-20","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-mar-97.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D135e576754b7d16f2825212161026e2f059862e63b6ff731596228838a5cf488%2Clid%3D1548%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db4069%2F24987%2F9873%2Fa19e12ae.2861426.4.2192826%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:13 volumio volumio[1021]: verbose: CURRENT POSITION 11 Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:13 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:13 volumio volumio[1021]: info: ------------------------------ 9ms Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:13 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:13 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:13 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:16 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:16 volumio sudo[3249]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/bin/bash run_peppymeter.sh Mar 09 17:30:16 volumio sudo[3249]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 17:30:16 volumio volumio[1021]: 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 09 17:30:16 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:16 volumio volumio[1021]: 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: 11 Mar 09 17:30:16 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:18 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand next took 5 milliseconds Mar 09 17:30:18 volumio volumio[1021]: info: Mar 09 17:30:18 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:18 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:18 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getTrack 11 Mar 09 17:30:18 volumio volumio[1021]: 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 09 17:30:18 volumio volumio[1021]: verbose: CURRENT POSITION 11 Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getTrack 12 Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getTrack 12 Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getTrack 12 Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:18 volumio volumio[1021]: info: ------------------------------ 10ms Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getTrack 12 Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand stop took 6 milliseconds Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:18 volumio volumio[1021]: info: Mar 09 17:30:18 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:18 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand clear took 3 milliseconds Mar 09 17:30:18 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:18 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6d2052184b28ab5e7417dcfca29a5abe08f2d5aa53f4278e1ae4648db4ec5aca%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2377%2F0%2F13220186%2F31098c6d.59828940.13.2470784%2Fflac&ext=.flac" Mar 09 17:30:18 volumio volumio[1021]: info: Mar 09 17:30:18 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:18 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6d2052184b28ab5e7417dcfca29a5abe08f2d5aa53f4278e1ae4648db4ec5aca%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2377%2F0%2F13220186%2F31098c6d.59828940.13.2470784%2Fflac&ext=.flac" took 0 milliseconds Mar 09 17:30:18 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:18 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:18 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:18 volumio volumio[1021]: info: Mar 09 17:30:18 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:18 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:18 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:18 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:18 volumio volumio[1021]: info: Mar 09 17:30:18 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:18 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:18 volumio volumio[1021]: info: Mar 09 17:30:18 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:30:18 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:18 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getTrack 12 Mar 09 17:30:18 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Life","artist":"Ace of Base","album":"Beautiful Life - The Singles Box","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6d2052184b28ab5e7417dcfca29a5abe08f2d5aa53f4278e1ae4648db4ec5aca%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2377%2F0%2F13220186%2F31098c6d.59828940.13.2470784%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:18 volumio volumio[1021]: verbose: CURRENT POSITION 12 Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:18 volumio volumio[1021]: info: ------------------------------ 4ms Mar 09 17:30:18 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:18 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:18 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getTrack 12 Mar 09 17:30:18 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beautiful Life","artist":"Ace of Base","album":"Beautiful Life - The Singles Box","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6d2052184b28ab5e7417dcfca29a5abe08f2d5aa53f4278e1ae4648db4ec5aca%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2377%2F0%2F13220186%2F31098c6d.59828940.13.2470784%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:18 volumio volumio[1021]: verbose: CURRENT POSITION 12 Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:18 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:18 volumio volumio[1021]: info: ------------------------------ 10ms Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:18 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:18 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:18 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:21 volumio volumio[1021]: 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: 11 Mar 09 17:30:21 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:23 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:23 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:23 volumio volumio[1021]: info: sendMpdCommand next took 47 milliseconds Mar 09 17:30:23 volumio volumio[1021]: info: Mar 09 17:30:23 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:23 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:23 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:23 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:23 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:23 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:23 volumio volumio[1021]: info: CorePlayQueue::getTrack 12 Mar 09 17:30:23 volumio volumio[1021]: 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 09 17:30:23 volumio volumio[1021]: verbose: CURRENT POSITION 12 Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:23 volumio volumio[1021]: info: CorePlayQueue::getTrack 13 Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:23 volumio volumio[1021]: info: CorePlayQueue::getTrack 13 Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:23 volumio volumio[1021]: info: CorePlayQueue::getTrack 13 Mar 09 17:30:23 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:23 volumio volumio[1021]: info: ------------------------------ 8ms Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:23 volumio volumio[1021]: info: CorePlayQueue::getTrack 13 Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:23 volumio volumio[1021]: info: sendMpdCommand stop took 5 milliseconds Mar 09 17:30:23 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:23 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:23 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:23 volumio volumio[1021]: info: Mar 09 17:30:23 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:23 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:23 volumio volumio[1021]: info: sendMpdCommand clear took 4 milliseconds Mar 09 17:30:23 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:23 volumio volumio[1021]: info: ------------------------------ 5ms Mar 09 17:30:23 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dea080facadea9970f9fa8f9ec701e8b20f48ae0ea559d9615b152e2ae0f59d71%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbe057%2F0%2F12899932%2Fbcee8527.79883077.12.53731927%2Fflac&ext=.flac" Mar 09 17:30:23 volumio volumio[1021]: info: Mar 09 17:30:23 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:23 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:23 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dea080facadea9970f9fa8f9ec701e8b20f48ae0ea559d9615b152e2ae0f59d71%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbe057%2F0%2F12899932%2Fbcee8527.79883077.12.53731927%2Fflac&ext=.flac" took 0 milliseconds Mar 09 17:30:23 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:23 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:23 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:23 volumio volumio[1021]: info: Mar 09 17:30:23 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:23 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:23 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:23 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:23 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:23 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:23 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:24 volumio volumio[1021]: info: Mar 09 17:30:24 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:24 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:24 volumio volumio[1021]: info: Mar 09 17:30:24 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:24 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:30:24 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:24 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:24 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:24 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:24 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:24 volumio volumio[1021]: info: CorePlayQueue::getTrack 13 Mar 09 17:30:24 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Песня идущего домой","artist":"Ю-Питер","album":"Биографика","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dea080facadea9970f9fa8f9ec701e8b20f48ae0ea559d9615b152e2ae0f59d71%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbe057%2F0%2F12899932%2Fbcee8527.79883077.12.53731927%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:24 volumio volumio[1021]: verbose: CURRENT POSITION 13 Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:24 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:30:24 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:24 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:24 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:24 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:24 volumio volumio[1021]: info: CorePlayQueue::getTrack 13 Mar 09 17:30:24 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":171,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Песня идущего домой","artist":"Ю-Питер","album":"Биографика","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dea080facadea9970f9fa8f9ec701e8b20f48ae0ea559d9615b152e2ae0f59d71%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbe057%2F0%2F12899932%2Fbcee8527.79883077.12.53731927%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:24 volumio volumio[1021]: verbose: CURRENT POSITION 13 Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:24 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:24 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:24 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:24 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:24 volumio volumio[1021]: info: ------------------------------ 7ms Mar 09 17:30:24 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:24 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:24 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:24 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:24 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:26 volumio volumio[1021]: 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: 11 Mar 09 17:30:26 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:29 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:29 volumio volumio[1021]: info: Mar 09 17:30:29 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:29 volumio volumio[1021]: info: sendMpdCommand next took 5 milliseconds Mar 09 17:30:29 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:29 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:29 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 13 Mar 09 17:30:29 volumio volumio[1021]: 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 09 17:30:29 volumio volumio[1021]: verbose: CURRENT POSITION 13 Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 14 Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 14 Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 14 Mar 09 17:30:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:29 volumio volumio[1021]: info: ------------------------------ 7ms Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 14 Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:29 volumio volumio[1021]: info: sendMpdCommand stop took 4 milliseconds Mar 09 17:30:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:29 volumio volumio[1021]: info: Mar 09 17:30:29 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:29 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:29 volumio volumio[1021]: info: sendMpdCommand clear took 5 milliseconds Mar 09 17:30:29 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:29 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:30:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8a4700ad541680598e311145a74d993bfaddf3262cba2e8a535087980ae52ce0%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dade2d%2F0%2F20909%2Fb80bbf68.1037919.732400%2F320.mp3&ext=.mp3" Mar 09 17:30:29 volumio volumio[1021]: info: Mar 09 17:30:29 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:29 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:29 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8a4700ad541680598e311145a74d993bfaddf3262cba2e8a535087980ae52ce0%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dade2d%2F0%2F20909%2Fb80bbf68.1037919.732400%2F320.mp3&ext=.mp3" took 1 milliseconds Mar 09 17:30:29 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:29 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:29 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:29 volumio volumio[1021]: info: Mar 09 17:30:29 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:29 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:29 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:29 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:29 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:29 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:30 volumio volumio[1021]: info: Mar 09 17:30:30 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:30 volumio volumio[1021]: info: Mar 09 17:30:30 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:30 volumio volumio[1021]: info: sendMpdCommand status took 3 milliseconds Mar 09 17:30:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:30 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 14 Mar 09 17:30:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"П.М.М.Л.","artist":"Земфира","album":"ПРОСТИ МЕНЯ МОЯ ЛЮБОВЬ","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8a4700ad541680598e311145a74d993bfaddf3262cba2e8a535087980ae52ce0%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dade2d%2F0%2F20909%2Fb80bbf68.1037919.732400%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:30 volumio volumio[1021]: verbose: CURRENT POSITION 14 Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:30 volumio volumio[1021]: info: ------------------------------ 4ms Mar 09 17:30:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 14 Mar 09 17:30:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":754,"duration":217,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"П.М.М.Л.","artist":"Земфира","album":"ПРОСТИ МЕНЯ МОЯ ЛЮБОВЬ","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8a4700ad541680598e311145a74d993bfaddf3262cba2e8a535087980ae52ce0%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dade2d%2F0%2F20909%2Fb80bbf68.1037919.732400%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:30 volumio volumio[1021]: verbose: CURRENT POSITION 14 Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:30 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:30 volumio volumio[1021]: info: ------------------------------ 6ms Mar 09 17:30:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:32 volumio volumio[1021]: 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: 11 Mar 09 17:30:32 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:33 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand next took 17 milliseconds Mar 09 17:30:33 volumio volumio[1021]: info: Mar 09 17:30:33 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:33 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:33 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getTrack 14 Mar 09 17:30:33 volumio volumio[1021]: 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 09 17:30:33 volumio volumio[1021]: verbose: CURRENT POSITION 14 Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getTrack 15 Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getTrack 15 Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getTrack 15 Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:33 volumio volumio[1021]: info: ------------------------------ 6ms Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getTrack 15 Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand stop took 4 milliseconds Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:33 volumio volumio[1021]: info: Mar 09 17:30:33 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:33 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand clear took 2 milliseconds Mar 09 17:30:33 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:33 volumio volumio[1021]: info: ------------------------------ 7ms Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D263236292ac0d4dd41ab1d38427f18d8ee3b5ea233fcb6716bb4ecc50c1f1d42%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db3933%2F0%2F12719191%2F27b024be.97733190.12.65117503%2Fflac&ext=.flac" Mar 09 17:30:33 volumio volumio[1021]: info: Mar 09 17:30:33 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:33 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D263236292ac0d4dd41ab1d38427f18d8ee3b5ea233fcb6716bb4ecc50c1f1d42%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db3933%2F0%2F12719191%2F27b024be.97733190.12.65117503%2Fflac&ext=.flac" took 1 milliseconds Mar 09 17:30:33 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:33 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:33 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:33 volumio volumio[1021]: info: Mar 09 17:30:33 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:33 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:33 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:33 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:33 volumio volumio[1021]: info: Mar 09 17:30:33 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:33 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:33 volumio volumio[1021]: info: Mar 09 17:30:33 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:30:33 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:33 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getTrack 15 Mar 09 17:30:33 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Na Zare","artist":"Gorilla Zippo","album":"Live in Miami","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D263236292ac0d4dd41ab1d38427f18d8ee3b5ea233fcb6716bb4ecc50c1f1d42%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db3933%2F0%2F12719191%2F27b024be.97733190.12.65117503%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:33 volumio volumio[1021]: verbose: CURRENT POSITION 15 Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:33 volumio volumio[1021]: info: ------------------------------ 5ms Mar 09 17:30:33 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:33 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:33 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:33 volumio volumio[1021]: info: CorePlayQueue::getTrack 15 Mar 09 17:30:33 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":246,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Na Zare","artist":"Gorilla Zippo","album":"Live in Miami","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D263236292ac0d4dd41ab1d38427f18d8ee3b5ea233fcb6716bb4ecc50c1f1d42%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db3933%2F0%2F12719191%2F27b024be.97733190.12.65117503%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:33 volumio volumio[1021]: verbose: CURRENT POSITION 15 Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:33 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:33 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:33 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:34 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:34 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:34 volumio volumio[1021]: info: ------------------------------ 11ms Mar 09 17:30:34 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:34 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:34 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:34 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:34 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:34 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:35 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:35 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:35 volumio volumio[1021]: info: Mar 09 17:30:35 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:35 volumio volumio[1021]: info: sendMpdCommand next took 3 milliseconds Mar 09 17:30:35 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:35 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:35 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:35 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:35 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:35 volumio volumio[1021]: info: CorePlayQueue::getTrack 15 Mar 09 17:30:35 volumio volumio[1021]: 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 09 17:30:35 volumio volumio[1021]: verbose: CURRENT POSITION 15 Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:35 volumio volumio[1021]: info: CorePlayQueue::getTrack 16 Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:35 volumio volumio[1021]: info: CorePlayQueue::getTrack 16 Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:35 volumio volumio[1021]: info: CorePlayQueue::getTrack 16 Mar 09 17:30:35 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:35 volumio volumio[1021]: info: ------------------------------ 8ms Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:35 volumio volumio[1021]: info: CorePlayQueue::getTrack 16 Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:35 volumio volumio[1021]: info: sendMpdCommand stop took 5 milliseconds Mar 09 17:30:35 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:35 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:35 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:35 volumio volumio[1021]: info: Mar 09 17:30:35 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:35 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:35 volumio volumio[1021]: info: sendMpdCommand clear took 3 milliseconds Mar 09 17:30:35 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:35 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:30:35 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1ad17d70b3f75f05d405db5b3fa2e155a9256fddef2cab345a4e54fbe055f43c%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db5c7e%2F0%2F1441034%2F979fe960.195921899.8.502747%2Fflac&ext=.flac" Mar 09 17:30:35 volumio volumio[1021]: info: Mar 09 17:30:35 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:35 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:35 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1ad17d70b3f75f05d405db5b3fa2e155a9256fddef2cab345a4e54fbe055f43c%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db5c7e%2F0%2F1441034%2F979fe960.195921899.8.502747%2Fflac&ext=.flac" took 0 milliseconds Mar 09 17:30:35 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:35 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:35 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:35 volumio volumio[1021]: info: Mar 09 17:30:35 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:35 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:35 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:35 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:35 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:35 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:35 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:36 volumio volumio[1021]: info: Mar 09 17:30:36 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:36 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:36 volumio volumio[1021]: info: Mar 09 17:30:36 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:36 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:36 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:36 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:36 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:36 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:36 volumio volumio[1021]: info: CorePlayQueue::getTrack 16 Mar 09 17:30:36 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bullwinkle, Pt. II","artist":"The Centurians","album":"Surfers' Pajama Party","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1ad17d70b3f75f05d405db5b3fa2e155a9256fddef2cab345a4e54fbe055f43c%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db5c7e%2F0%2F1441034%2F979fe960.195921899.8.502747%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:36 volumio volumio[1021]: verbose: CURRENT POSITION 16 Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:36 volumio volumio[1021]: info: ------------------------------ 2ms Mar 09 17:30:36 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:36 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:36 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:36 volumio volumio[1021]: info: CorePlayQueue::getTrack 16 Mar 09 17:30:36 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":137,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bullwinkle, Pt. II","artist":"The Centurians","album":"Surfers' Pajama Party","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1ad17d70b3f75f05d405db5b3fa2e155a9256fddef2cab345a4e54fbe055f43c%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db5c7e%2F0%2F1441034%2F979fe960.195921899.8.502747%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:36 volumio volumio[1021]: verbose: CURRENT POSITION 16 Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:36 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:36 volumio volumio[1021]: info: ------------------------------ 7ms Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:36 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:36 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:36 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:36 volumio volumio[1021]: 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: 11 Mar 09 17:30:36 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:39 volumio volumio[1021]: 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: 12 Mar 09 17:30:39 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:43 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand next took 9 milliseconds Mar 09 17:30:43 volumio volumio[1021]: info: Mar 09 17:30:43 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:43 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:43 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getTrack 16 Mar 09 17:30:43 volumio volumio[1021]: 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 09 17:30:43 volumio volumio[1021]: verbose: CURRENT POSITION 16 Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getTrack 17 Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getTrack 17 Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getTrack 17 Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:43 volumio volumio[1021]: info: ------------------------------ 7ms Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getTrack 17 Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand stop took 5 milliseconds Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:43 volumio volumio[1021]: info: Mar 09 17:30:43 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:43 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand clear took 3 milliseconds Mar 09 17:30:43 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:43 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3742265ca3aa689ce184d64e0f9dfde54e7d7d62f60ed067f0aecfb654fb4e5d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbd52f%2F0%2F9877%2F58783f83.2873259.2200853%2F2.mp3&ext=.mp3" Mar 09 17:30:43 volumio volumio[1021]: info: Mar 09 17:30:43 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:43 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3742265ca3aa689ce184d64e0f9dfde54e7d7d62f60ed067f0aecfb654fb4e5d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbd52f%2F0%2F9877%2F58783f83.2873259.2200853%2F2.mp3&ext=.mp3" took 0 milliseconds Mar 09 17:30:43 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:43 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:43 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:43 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:43 volumio volumio[1021]: info: Mar 09 17:30:43 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:43 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:43 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:43 volumio volumio[1021]: info: Mar 09 17:30:43 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:43 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:43 volumio volumio[1021]: info: Mar 09 17:30:43 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:43 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:43 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getTrack 17 Mar 09 17:30:43 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":131,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Там, на самом краю земли","artist":"Пикник","album":"Харакири","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3742265ca3aa689ce184d64e0f9dfde54e7d7d62f60ed067f0aecfb654fb4e5d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbd52f%2F0%2F9877%2F58783f83.2873259.2200853%2F2.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:43 volumio volumio[1021]: verbose: CURRENT POSITION 17 Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:43 volumio volumio[1021]: info: ------------------------------ 4ms Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:43 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:43 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:43 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getTrack 17 Mar 09 17:30:43 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":131,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Там, на самом краю земли","artist":"Пикник","album":"Харакири","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3742265ca3aa689ce184d64e0f9dfde54e7d7d62f60ed067f0aecfb654fb4e5d%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dbd52f%2F0%2F9877%2F58783f83.2873259.2200853%2F2.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:43 volumio volumio[1021]: verbose: CURRENT POSITION 17 Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:43 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:43 volumio volumio[1021]: info: ------------------------------ 8ms Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:43 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:43 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:43 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:46 volumio sudo[3249]: pam_unix(sudo:session): session closed for user root Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:48 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:48 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:48 volumio volumio[1021]: info: sendMpdCommand next took 12 milliseconds Mar 09 17:30:48 volumio volumio[1021]: info: Mar 09 17:30:48 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:48 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:48 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:48 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:48 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:48 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:48 volumio volumio[1021]: info: CorePlayQueue::getTrack 17 Mar 09 17:30:48 volumio volumio[1021]: 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 09 17:30:48 volumio volumio[1021]: verbose: CURRENT POSITION 17 Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:48 volumio volumio[1021]: info: CorePlayQueue::getTrack 18 Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:48 volumio volumio[1021]: info: CorePlayQueue::getTrack 18 Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:48 volumio volumio[1021]: info: CorePlayQueue::getTrack 18 Mar 09 17:30:48 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:48 volumio volumio[1021]: info: ------------------------------ 6ms Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:48 volumio volumio[1021]: info: CorePlayQueue::getTrack 18 Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:48 volumio volumio[1021]: info: sendMpdCommand stop took 5 milliseconds Mar 09 17:30:48 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:48 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:48 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:48 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:48 volumio volumio[1021]: info: Mar 09 17:30:48 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:48 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:48 volumio volumio[1021]: info: sendMpdCommand clear took 3 milliseconds Mar 09 17:30:48 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:48 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D71be004078bf0d1365f6a43db5ca9847d5caf78ae32f2498a32618b59845fcad%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2961%2F0%2F40827%2F8589bdc0.4990929.3747481%2F320.mp3&ext=.mp3" Mar 09 17:30:49 volumio volumio[1021]: info: Mar 09 17:30:49 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:49 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:49 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D71be004078bf0d1365f6a43db5ca9847d5caf78ae32f2498a32618b59845fcad%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2961%2F0%2F40827%2F8589bdc0.4990929.3747481%2F320.mp3&ext=.mp3" took 0 milliseconds Mar 09 17:30:49 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:49 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:49 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:49 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:49 volumio volumio[1021]: info: Mar 09 17:30:49 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:49 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:49 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:49 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:49 volumio volumio[1021]: info: Mar 09 17:30:49 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:49 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:49 volumio volumio[1021]: info: Mar 09 17:30:49 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:49 volumio volumio[1021]: info: sendMpdCommand status took 3 milliseconds Mar 09 17:30:49 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:49 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:49 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:49 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:49 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:49 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:49 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:49 volumio volumio[1021]: info: CorePlayQueue::getTrack 18 Mar 09 17:30:49 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":338,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Молитва","artist":"Би-2","album":"Spirit","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D71be004078bf0d1365f6a43db5ca9847d5caf78ae32f2498a32618b59845fcad%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2961%2F0%2F40827%2F8589bdc0.4990929.3747481%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:49 volumio volumio[1021]: verbose: CURRENT POSITION 18 Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:49 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:49 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:49 volumio volumio[1021]: info: CorePlayQueue::getTrack 18 Mar 09 17:30:49 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":885,"duration":338,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Молитва","artist":"Би-2","album":"Spirit","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1539.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D71be004078bf0d1365f6a43db5ca9847d5caf78ae32f2498a32618b59845fcad%2Clid%3D1539%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db2961%2F0%2F40827%2F8589bdc0.4990929.3747481%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:49 volumio volumio[1021]: verbose: CURRENT POSITION 18 Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:49 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:49 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:49 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:49 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:49 volumio volumio[1021]: info: ------------------------------ 7ms Mar 09 17:30:49 volumio volumio[1021]: info: ------------------------------ 8ms Mar 09 17:30:49 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:49 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:49 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:49 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:49 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:50 volumio volumio[1021]: 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 09 17:30:50 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:51 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:51 volumio sudo[3740]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/bin/bash run_peppymeter.sh Mar 09 17:30:51 volumio sudo[3740]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 09 17:30:51 volumio volumio[1021]: 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: 11 Mar 09 17:30:51 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:51 volumio volumio[1021]: 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: 12 Mar 09 17:30:51 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:54 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand next took 11 milliseconds Mar 09 17:30:54 volumio volumio[1021]: info: Mar 09 17:30:54 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:54 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:54 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getTrack 18 Mar 09 17:30:54 volumio volumio[1021]: 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 09 17:30:54 volumio volumio[1021]: verbose: CURRENT POSITION 18 Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getTrack 19 Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getTrack 19 Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getTrack 19 Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:54 volumio volumio[1021]: info: ------------------------------ 9ms Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getTrack 19 Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand stop took 7 milliseconds Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:54 volumio volumio[1021]: info: Mar 09 17:30:54 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:54 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand clear took 3 milliseconds Mar 09 17:30:54 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:54 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddcc568921381564ef6f2f8487d98f9af8859d172c2a83ea85b1b90b5fd010447%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db650e%2F0%2F245111%2F8d9aa92c.61606870.21.40817894%2Fflac&ext=.flac" Mar 09 17:30:54 volumio volumio[1021]: info: Mar 09 17:30:54 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:54 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddcc568921381564ef6f2f8487d98f9af8859d172c2a83ea85b1b90b5fd010447%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db650e%2F0%2F245111%2F8d9aa92c.61606870.21.40817894%2Fflac&ext=.flac" took 1 milliseconds Mar 09 17:30:54 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:54 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:54 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:54 volumio volumio[1021]: info: Mar 09 17:30:54 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:54 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:54 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:54 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand play took 1 milliseconds Mar 09 17:30:54 volumio volumio[1021]: info: Mar 09 17:30:54 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:54 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:54 volumio volumio[1021]: info: Mar 09 17:30:54 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:30:54 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:54 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getTrack 19 Mar 09 17:30:54 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аргентина-Ямайка - 5:0","artist":"ЧайФ","album":"Шекогали","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddcc568921381564ef6f2f8487d98f9af8859d172c2a83ea85b1b90b5fd010447%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db650e%2F0%2F245111%2F8d9aa92c.61606870.21.40817894%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:54 volumio volumio[1021]: verbose: CURRENT POSITION 19 Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:54 volumio volumio[1021]: info: ------------------------------ 4ms Mar 09 17:30:54 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:54 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:54 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getTrack 19 Mar 09 17:30:54 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Аргентина-Ямайка - 5:0","artist":"ЧайФ","album":"Шекогали","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddcc568921381564ef6f2f8487d98f9af8859d172c2a83ea85b1b90b5fd010447%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db650e%2F0%2F245111%2F8d9aa92c.61606870.21.40817894%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:30:54 volumio volumio[1021]: verbose: CURRENT POSITION 19 Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:54 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:54 volumio volumio[1021]: info: ------------------------------ 9ms Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:54 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:54 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:54 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:30:57 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:30:57 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:30:57 volumio volumio[1021]: info: sendMpdCommand next took 7 milliseconds Mar 09 17:30:57 volumio volumio[1021]: info: Mar 09 17:30:57 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:57 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:57 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:57 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:30:57 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:57 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:57 volumio volumio[1021]: info: CorePlayQueue::getTrack 19 Mar 09 17:30:57 volumio volumio[1021]: 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 09 17:30:57 volumio volumio[1021]: verbose: CURRENT POSITION 19 Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:57 volumio volumio[1021]: info: CorePlayQueue::getTrack 20 Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:57 volumio volumio[1021]: info: CorePlayQueue::getTrack 20 Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:30:57 volumio volumio[1021]: info: CorePlayQueue::getTrack 20 Mar 09 17:30:57 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:30:57 volumio volumio[1021]: info: ------------------------------ 10ms Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:57 volumio volumio[1021]: info: CorePlayQueue::getTrack 20 Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:57 volumio volumio[1021]: info: sendMpdCommand stop took 5 milliseconds Mar 09 17:30:57 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:57 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:57 volumio volumio[1021]: info: Mar 09 17:30:57 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:57 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:57 volumio volumio[1021]: info: sendMpdCommand clear took 3 milliseconds Mar 09 17:30:57 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:30:57 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:30:57 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1521.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D49a034f872068e44bd6f8dfcda38a236c810b2b7dea17ab73bdba6e96e383b22%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db6c85%2F31571%2F1738553%2Fcaeb6d24.107042770.8.32193068%2F320.mp3&ext=.mp3" Mar 09 17:30:57 volumio volumio[1021]: info: Mar 09 17:30:57 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:57 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:57 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1521.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D49a034f872068e44bd6f8dfcda38a236c810b2b7dea17ab73bdba6e96e383b22%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db6c85%2F31571%2F1738553%2Fcaeb6d24.107042770.8.32193068%2F320.mp3&ext=.mp3" took 0 milliseconds Mar 09 17:30:57 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:57 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:57 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:30:57 volumio volumio[1021]: info: Mar 09 17:30:57 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:30:57 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:30:57 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:30:57 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:30:57 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:30:57 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:30:57 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:30:57 volumio volumio[1021]: 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: 12 Mar 09 17:30:57 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:30:58 volumio volumio[1021]: info: Mar 09 17:30:58 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:58 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:58 volumio volumio[1021]: info: Mar 09 17:30:58 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:30:58 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:30:58 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:58 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:30:58 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:58 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:58 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:58 volumio volumio[1021]: info: CorePlayQueue::getTrack 20 Mar 09 17:30:58 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":201,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Morricone: Chi Mai","artist":"Ennio Morricone","album":"The Art of Ennio Morricone","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1521.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D49a034f872068e44bd6f8dfcda38a236c810b2b7dea17ab73bdba6e96e383b22%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db6c85%2F31571%2F1738553%2Fcaeb6d24.107042770.8.32193068%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:58 volumio volumio[1021]: verbose: CURRENT POSITION 20 Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:30:58 volumio volumio[1021]: info: ------------------------------ 4ms Mar 09 17:30:58 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:30:58 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:30:58 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:30:58 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:30:58 volumio volumio[1021]: info: CorePlayQueue::getTrack 20 Mar 09 17:30:58 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":754,"duration":201,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Morricone: Chi Mai","artist":"Ennio Morricone","album":"The Art of Ennio Morricone","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1521.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D49a034f872068e44bd6f8dfcda38a236c810b2b7dea17ab73bdba6e96e383b22%2Clid%3D1521%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67db6c85%2F31571%2F1738553%2Fcaeb6d24.107042770.8.32193068%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 09 17:30:58 volumio volumio[1021]: verbose: CURRENT POSITION 20 Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:30:58 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:58 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:30:58 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:30:58 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:30:58 volumio volumio[1021]: info: ------------------------------ 9ms Mar 09 17:30:58 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:58 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:30:58 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:30:58 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:30:58 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:00 volumio volumio[1021]: 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: 12 Mar 09 17:31:00 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::volumioNext Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::next Mar 09 17:31:01 volumio volumio[1021]: info: ControllerMpd::next Mar 09 17:31:01 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand next Mar 09 17:31:01 volumio volumio[1021]: info: sendMpdCommand next took 19 milliseconds Mar 09 17:31:01 volumio volumio[1021]: info: Mar 09 17:31:01 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:31:01 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:01 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:01 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:01 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:01 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:01 volumio volumio[1021]: info: CorePlayQueue::getTrack 20 Mar 09 17:31:01 volumio volumio[1021]: 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 09 17:31:01 volumio volumio[1021]: verbose: CURRENT POSITION 20 Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::syncState stateService stop Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::play index undefined Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:01 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:01 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::startPlaybackTimer Mar 09 17:31:01 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:01 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand stop Mar 09 17:31:01 volumio volumio[1021]: info: ------------------------------ 8ms Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:01 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:01 volumio volumio[1021]: info: sendMpdCommand stop took 5 milliseconds Mar 09 17:31:01 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand clear Mar 09 17:31:01 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:01 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:01 volumio volumio[1021]: info: Mar 09 17:31:01 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:31:01 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:31:01 volumio volumio[1021]: info: sendMpdCommand clear took 4 milliseconds Mar 09 17:31:01 volumio volumio[1021]: error: updateQueue error: null Mar 09 17:31:01 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:31:01 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac" Mar 09 17:31:01 volumio volumio[1021]: info: Mar 09 17:31:01 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:31:01 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:31:01 volumio volumio[1021]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac" took 1 milliseconds Mar 09 17:31:01 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:31:01 volumio volumio[1021]: verbose: MPD COMMAND [object Object] Mar 09 17:31:01 volumio volumio[1021]: info: Mar 09 17:31:01 volumio volumio[1021]: ---------------------------- MPD announces system playlist update Mar 09 17:31:01 volumio volumio[1021]: info: Ignoring MPD Status Update Mar 09 17:31:01 volumio volumio[1021]: info: ------------------------------ 1ms Mar 09 17:31:01 volumio volumio[1021]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 09 17:31:01 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand play Mar 09 17:31:01 volumio volumio[1021]: info: ------------------------------ 0ms Mar 09 17:31:01 volumio volumio[1021]: info: sendMpdCommand play took 0 milliseconds Mar 09 17:31:02 volumio volumio[1021]: info: Mar 09 17:31:02 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:31:02 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:02 volumio volumio[1021]: info: Mar 09 17:31:02 volumio volumio[1021]: ---------------------------- MPD announces state update: player Mar 09 17:31:02 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:31:02 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:02 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:02 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 0 milliseconds Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:02 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:02 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:02 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:02 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:02 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus stop Mar 09 17:31:02 volumio volumio[1021]: info: ------------------------------ 3ms Mar 09 17:31:02 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:31:02 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:02 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:02 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:02 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:02 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:02 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:02 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:02 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:02 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:02 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:02 volumio volumio[1021]: info: ------------------------------ 8ms Mar 09 17:31:02 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:02 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:02 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:02 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:02 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:05 volumio volumio[1021]: 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: 12 Mar 09 17:31:05 volumio volumio[1021]: info: CoreCommandRouter::volumioGetState Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 17:31:26 volumio volumio[1021]: info: Retrieving Cloud Streaming UI Mar 09 17:31:26 volumio volumio[1021]: info: Getting Tidal Cloud Configuration Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 17:31:26 volumio volumio[1021]: info: Getting Qobuz Cloud Configuration Mar 09 17:31:26 volumio volumio[1021]: info: Asking plugin for UI Config Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 17:31:26 volumio volumio[1021]: info: Getting Spotify Cloud Configuration Mar 09 17:31:26 volumio volumio[1021]: info: Asking plugin for UI Config Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 17:31:26 volumio volumio[1021]: info: Saving Spotify Acccount Mar 09 17:31:26 volumio volumio[1021]: info: Got Tidal Cloud Configuration Mar 09 17:31:26 volumio volumio[1021]: info: Got it Mar 09 17:31:26 volumio volumio[1021]: info: Got it Mar 09 17:31:26 volumio volumio[1021]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 09 17:31:26 volumio volumio[1021]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::volumioGetBrowseSources Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::volumioGetBrowseSources Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::volumioGetBrowseSources Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 09 17:31:26 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:27 volumio volumio[1021]: info: Mar 09 17:31:27 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:27 volumio volumio[1021]: info: sendMpdCommand rescan took 2 milliseconds Mar 09 17:31:27 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:27 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:27 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:27 volumio volumio[1021]: info: sendMpdCommand status took 14 milliseconds Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:27 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:27 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:27 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:27 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25589,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"995 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:27 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:27 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:27 volumio volumio[1021]: info: ------------------------------ 25ms Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:27 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:27 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:27 volumio volumio[1021]: info: Mar 09 17:31:27 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:27 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:27 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:27 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:27 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:27 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:27 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:27 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:27 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":25589,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"995 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:27 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:27 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:27 volumio volumio[1021]: info: ------------------------------ 28ms Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:27 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:27 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:27 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:27 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: Mar 09 17:31:28 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand rescan took 2 milliseconds Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: Mar 09 17:31:28 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:28 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":26340,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1055 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:28 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:28 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: ------------------------------ 20ms Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand status took 10 milliseconds Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand status took 10 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:28 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":26340,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1055 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:28 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:28 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: ------------------------------ 28ms Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: Mar 09 17:31:28 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand rescan took 1 milliseconds Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: Mar 09 17:31:28 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:28 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":26522,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"943 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:28 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:28 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: ------------------------------ 20ms Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand status took 12 milliseconds Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand status took 12 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:28 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:28 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:28 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:28 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":26522,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"943 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:28 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:28 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:28 volumio volumio[1021]: info: ------------------------------ 31ms Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:28 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:28 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand update Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: info: Mar 09 17:31:29 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand update took 2 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: info: Mar 09 17:31:29 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 14 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:29 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27092,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1090 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:29 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:29 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: ------------------------------ 31ms Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:29 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27183,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1039 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:29 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:29 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: ------------------------------ 27ms Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: info: Mar 09 17:31:29 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand rescan took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: info: Mar 09 17:31:29 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 13 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:29 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27638,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1135 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:29 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:29 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: ------------------------------ 34ms Mar 09 17:31:29 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 09 17:31:29 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:29 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:29 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":27638,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1135 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:29 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:29 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:29 volumio volumio[1021]: info: ------------------------------ 28ms Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:29 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:29 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: Mar 09 17:31:30 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand rescan took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: Mar 09 17:31:30 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 13 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28116,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1071 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:30 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:30 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: ------------------------------ 29ms Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28116,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1071 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:30 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:30 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: ------------------------------ 27ms Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand update Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: Mar 09 17:31:30 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand update took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: Mar 09 17:31:30 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28480,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1119 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:30 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:30 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: ------------------------------ 23ms Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 11 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 11 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28480,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1119 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:30 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:30 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: ------------------------------ 29ms Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: Mar 09 17:31:30 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand rescan took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: info: Mar 09 17:31:30 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 14 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28845,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1040 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:30 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:30 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: ------------------------------ 31ms Mar 09 17:31:30 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 09 17:31:30 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:30 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:30 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28845,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1040 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:30 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:30 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:30 volumio volumio[1021]: info: ------------------------------ 26ms Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:30 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:30 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand update Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: info: Mar 09 17:31:31 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand update took 1 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 2 milliseconds Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: info: Mar 09 17:31:31 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 16 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:31 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29232,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"911 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:31 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:31 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: ------------------------------ 33ms Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:31 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29232,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"911 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:31 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:31 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: ------------------------------ 24ms Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand rescan Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: info: Mar 09 17:31:31 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand rescan took 1 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 0 milliseconds Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: info: Command Router : Notfying DB Updatetrue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: info: Mar 09 17:31:31 volumio volumio[1021]: ---------------------------- MPD announces state update: update Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 12 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::getState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand status Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand status took 1 milliseconds Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: info: Command Router : Notfying DB Updatefalse Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::Close All Modals sent Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseState Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:31 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29505,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"1074 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:31 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:31 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: ------------------------------ 31ms Mar 09 17:31:31 volumio volumio[1021]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 09 17:31:31 volumio volumio[1021]: verbose: ControllerMpd::parseTrackInfo Mar 09 17:31:31 volumio volumio[1021]: info: ControllerMpd::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::servicePushState Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getTrack 21 Mar 09 17:31:31 volumio volumio[1021]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29505,"duration":172,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1074 Kbps","isStreaming":false,"title":"Свобода","artist":"Сергей Шнуров","album":"Бумер. Фильм второй","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fext-strm-rndttk-01.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dff04cb419fdf947b5cec83e3a9ba24cbd0d23fea4c71b4f04a058792bd3be23a%2Clid%3D1595%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67dc24d6%2F0%2F8242607%2Fcfe9ccf4.96568025.12.64357981%2Fflac&ext=.flac","trackType":"flac"} Mar 09 17:31:31 volumio volumio[1021]: verbose: CURRENT POSITION 21 Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState stateService play Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::syncState currentStatus play Mar 09 17:31:31 volumio volumio[1021]: info: Received an update from plugin. extracting info from payload Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::pushState Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioPushState Mar 09 17:31:31 volumio volumio[1021]: info: ------------------------------ 27ms Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreCommandRouter::volumioGetQueue Mar 09 17:31:31 volumio volumio[1021]: info: CoreStateMachine::getQueue Mar 09 17:31:31 volumio volumio[1021]: info: CorePlayQueue::getQueue Mar 09 17:31:33 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 09 17:31:33 volumio volumio[1021]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 09 17:31:33 volumio volumio[1021]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 17:31:33 volumio volumio[1021]: Error: getaddrinfo -3007 Mar 09 17:31:33 volumio volumio[1021]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Mar 09 17:31:33 volumio volumio[1021]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Mar 09 17:31:33 volumio volumio[1021]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Mar 09 17:31:33 volumio volumio[1021]: code: -3007, Mar 09 17:31:33 volumio volumio[1021]: errno: -3007, Mar 09 17:31:33 volumio volumio[1021]: syscall: 'getaddrinfo' Mar 09 17:31:33 volumio volumio[1021]: } Mar 09 17:31:33 volumio volumio[1021]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 09 17:31:33 volumio sudo[4553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-09 17:30 Mar 09 17:31:33 volumio sudo[4553]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"