-- Logs begin at Thu 2019-02-14 17:11:59 +07, end at Mon 2025-03-17 12:29:44 +07. -- Mar 17 12:28:37 volumio volumio[855]: verbose: New Socket.io Connection to 192.168.1.37 from 192.168.1.7 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/18.3 Mobile/15E148 Safari/604.1 Engine version: 3 Transport: polling Total Clients: 6 Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::volumioGetVisibleSources Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::volumioGetState Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 17 12:28:37 volumio volumio[855]: info: Received Get System Info Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 17 12:28:37 volumio volumio[855]: info: Discovery: Getting this device information Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::volumioGetState Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::volumioGetState Mar 17 12:28:37 volumio volumio[855]: info: Listing playlists Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:28:37 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:28:37 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:28:37 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:38 volumio volumio[855]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 17 12:28:42 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri Mar 17 12:28:42 volumio volumio[855]: info: Preload queue cleared Mar 17 12:28:42 volumio volumio[855]: info: Preload queue cleared Mar 17 12:28:42 volumio volumio[855]: info: Preload queue cleared Mar 17 12:28:42 volumio volumio[855]: info: Preload queue cleared Mar 17 12:28:42 volumio volumio[855]: info: Preload queue cleared Mar 17 12:28:55 volumio volumio[855]: info: Preload queue cleared Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::ClearQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::stop Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::stPlaybackTimer Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::serviceStop Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::serviceStop Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:28:55 volumio volumio[855]: info: ControllerMpd::stop Mar 17 12:28:55 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::clearPlayQueue Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:28:55 volumio volumio[855]: info: Preload queue cleared Mar 17 12:28:55 volumio volumio[855]: info: Adding Item to queue: yandex_music/radio/user:onyourwave Mar 17 12:28:55 volumio volumio[855]: info: Exploding uri yandex_music/radio/user:onyourwave in service yandex_music Mar 17 12:28:55 volumio volumio[855]: info: Mar 17 12:28:55 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:28:55 volumio volumio[855]: info: sendMpdCommand stop took 85 milliseconds Mar 17 12:28:55 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:28:55 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:28:55 volumio volumio[855]: info: sendMpdCommand status took 7 milliseconds Mar 17 12:28:55 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:28:55 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:28:55 volumio volumio[855]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 17 12:28:55 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:28:55 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:28:55 volumio volumio[855]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Experience","artist":"Ludovico Einaudi","album":"In A Time Lapse","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1537.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D98088994e4bfdeeeef7333f8afc0840b57f372b66fa8984f54c7d231b85c3815%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e506de%2F48703%2F15782%2Fb2a64385.113313859.18.8923879%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 17 12:28:55 volumio volumio[855]: verbose: CURRENT POSITION 1 Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:28:55 volumio volumio[855]: info: No code Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:28:55 volumio volumio[855]: info: ------------------------------ 39ms Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:28:55 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:28:55 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:28:56 volumio volumio[855]: info: camilladsp spawned new process with pid 20093, instance 1, run: true Mar 17 12:28:56 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:28:56 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:28:56 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:28:56 volumio volumio[855]: info: CoreCommandRouter::volumioPlay Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::play index 0 Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::stop Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:28:56 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:28:56 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Mar 17 12:28:56 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:28:56 volumio volumio[855]: info: sendMpdCommand stop took 7 milliseconds Mar 17 12:28:56 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:28:56 volumio volumio[855]: info: Mar 17 12:28:56 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:28:56 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:28:56 volumio volumio[855]: info: sendMpdCommand clear took 2 milliseconds Mar 17 12:28:56 volumio volumio[855]: error: updateQueue error: null Mar 17 12:28:56 volumio volumio[855]: info: ------------------------------ 14ms Mar 17 12:28:56 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1537.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8dad5c6ec1a50e7500473903d4e34f8aa4e0b5f75c997f07e54313888bd3883c%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e57d34%2F47391%2F16046%2F03cc254f.88542873.10.59670438%2F320.mp3&ext=.mp3" Mar 17 12:28:56 volumio volumio[855]: info: Mar 17 12:28:56 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:28:56 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:28:56 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1537.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8dad5c6ec1a50e7500473903d4e34f8aa4e0b5f75c997f07e54313888bd3883c%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e57d34%2F47391%2F16046%2F03cc254f.88542873.10.59670438%2F320.mp3&ext=.mp3" took 2 milliseconds Mar 17 12:28:56 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:28:56 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:28:56 volumio volumio[855]: info: Mar 17 12:28:56 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:28:56 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:28:56 volumio volumio[855]: info: ------------------------------ 5ms Mar 17 12:28:56 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:28:56 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:28:56 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:28:56 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:28:58 volumio volumio[855]: info: Mar 17 12:28:58 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:28:58 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:28:58 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:28:58 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:28:58 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:28:58 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:28:58 volumio volumio[855]: info: Mar 17 12:28:58 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:28:58 volumio volumio[855]: info: sendMpdCommand status took 38 milliseconds Mar 17 12:28:58 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:28:58 volumio volumio[855]: info: sendMpdCommand status took 4 milliseconds Mar 17 12:28:58 volumio volumio[855]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:28:58 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:28:58 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:28:58 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Mar 17 12:28:58 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"In Your Room","artist":"Tape Out","album":"Depeche Mode Tributo Argentino 2.0","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1537.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8dad5c6ec1a50e7500473903d4e34f8aa4e0b5f75c997f07e54313888bd3883c%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e57d34%2F47391%2F16046%2F03cc254f.88542873.10.59670438%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 17 12:28:58 volumio volumio[855]: verbose: CURRENT POSITION 0 Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:28:58 volumio volumio[855]: info: ------------------------------ 49ms Mar 17 12:28:58 volumio volumio[855]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 17 12:28:58 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:28:58 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:28:58 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:28:58 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Mar 17 12:28:58 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":304,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"In Your Room","artist":"Tape Out","album":"Depeche Mode Tributo Argentino 2.0","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1537.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8dad5c6ec1a50e7500473903d4e34f8aa4e0b5f75c997f07e54313888bd3883c%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e57d34%2F47391%2F16046%2F03cc254f.88542873.10.59670438%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 17 12:28:58 volumio volumio[855]: verbose: CURRENT POSITION 0 Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:28:58 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:28:58 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:28:58 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:28:58 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:28:58 volumio volumio[855]: info: ------------------------------ 26ms Mar 17 12:28:58 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:28:58 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:28:58 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:28:58 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:28:58 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:28:58 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:03 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:03 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:03 volumio volumio[855]: info: Mar 17 12:29:03 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:03 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:03 volumio volumio[855]: info: Mar 17 12:29:03 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:03 volumio volumio[855]: info: sendMpdCommand next took 5 milliseconds Mar 17 12:29:03 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:03 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:03 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:03 volumio volumio[855]: info: ------------------------------ 4ms Mar 17 12:29:03 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:03 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:03 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:03 volumio volumio[855]: info: CorePlayQueue::getTrack 0 Mar 17 12:29:03 volumio volumio[855]: 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 17 12:29:03 volumio volumio[855]: verbose: CURRENT POSITION 0 Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:03 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:03 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:03 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:29:03 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:03 volumio volumio[855]: info: ------------------------------ 26ms Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:03 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:03 volumio volumio[855]: info: sendMpdCommand stop took 15 milliseconds Mar 17 12:29:03 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:03 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:03 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:03 volumio volumio[855]: info: Mar 17 12:29:03 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:03 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:03 volumio volumio[855]: info: sendMpdCommand clear took 17 milliseconds Mar 17 12:29:03 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:03 volumio volumio[855]: info: ------------------------------ 10ms Mar 17 12:29:03 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8658332555e2ec26eaea54ab7acdad9c402edb84bd0992df49187d749a5da5db%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5d9f3%2F0%2F1031985%2Fa9ab3ada.61593850.8.40807024%2F320.mp3&ext=.mp3" Mar 17 12:29:03 volumio volumio[855]: info: Mar 17 12:29:03 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:03 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:03 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8658332555e2ec26eaea54ab7acdad9c402edb84bd0992df49187d749a5da5db%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5d9f3%2F0%2F1031985%2Fa9ab3ada.61593850.8.40807024%2F320.mp3&ext=.mp3" took 3 milliseconds Mar 17 12:29:03 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:03 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:03 volumio volumio[855]: info: Mar 17 12:29:03 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:03 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:03 volumio volumio[855]: info: ------------------------------ 4ms Mar 17 12:29:03 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:03 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:03 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:03 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:29:04 volumio volumio[855]: info: camilladsp spawned new process with pid 20119, instance 1, run: true Mar 17 12:29:04 volumio volumio[855]: info: Mar 17 12:29:04 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:04 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:04 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:04 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:04 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:04 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:04 volumio volumio[855]: info: Mar 17 12:29:04 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:04 volumio volumio[855]: info: sendMpdCommand status took 30 milliseconds Mar 17 12:29:04 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:04 volumio volumio[855]: info: sendMpdCommand status took 6 milliseconds Mar 17 12:29:04 volumio volumio[855]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:04 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:04 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:04 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:29:04 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Enemy Crush","artist":"Skrip Breaks","album":"Battle of the Year 2007 - The Soundtrack","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8658332555e2ec26eaea54ab7acdad9c402edb84bd0992df49187d749a5da5db%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5d9f3%2F0%2F1031985%2Fa9ab3ada.61593850.8.40807024%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 17 12:29:04 volumio volumio[855]: verbose: CURRENT POSITION 1 Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:04 volumio volumio[855]: info: ------------------------------ 43ms Mar 17 12:29:04 volumio volumio[855]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 17 12:29:04 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:04 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:04 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:04 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:29:04 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1359,"duration":238,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Enemy Crush","artist":"Skrip Breaks","album":"Battle of the Year 2007 - The Soundtrack","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D8658332555e2ec26eaea54ab7acdad9c402edb84bd0992df49187d749a5da5db%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5d9f3%2F0%2F1031985%2Fa9ab3ada.61593850.8.40807024%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 17 12:29:04 volumio volumio[855]: verbose: CURRENT POSITION 1 Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:04 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:04 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:04 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:04 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:04 volumio volumio[855]: info: ------------------------------ 27ms Mar 17 12:29:04 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:04 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:04 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:04 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:04 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:04 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:05 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:05 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/639773:68481@user:onyourwave Mar 17 12:29:05 volumio volumio[855]: info: Exploding uri yandex_music/track/639773:68481@user:onyourwave in service yandex_music Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:05 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:05 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/91131796:18101380@user:onyourwave Mar 17 12:29:05 volumio volumio[855]: info: Exploding uri yandex_music/track/91131796:18101380@user:onyourwave in service yandex_music Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:05 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:05 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/62509240:9863572@user:onyourwave Mar 17 12:29:05 volumio volumio[855]: info: Exploding uri yandex_music/track/62509240:9863572@user:onyourwave in service yandex_music Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:05 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:05 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:05 volumio volumio[855]: info: Mar 17 12:29:05 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:05 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:05 volumio volumio[855]: info: Mar 17 12:29:05 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:05 volumio volumio[855]: info: sendMpdCommand next took 5 milliseconds Mar 17 12:29:05 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:05 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:05 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:05 volumio volumio[855]: info: ------------------------------ 4ms Mar 17 12:29:05 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:05 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:05 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrack 1 Mar 17 12:29:05 volumio volumio[855]: 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 17 12:29:05 volumio volumio[855]: verbose: CURRENT POSITION 1 Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrack 2 Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrack 2 Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrack 2 Mar 17 12:29:05 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:05 volumio volumio[855]: info: ------------------------------ 16ms Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getTrack 2 Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:05 volumio volumio[855]: info: sendMpdCommand stop took 14 milliseconds Mar 17 12:29:05 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:05 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:05 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:05 volumio volumio[855]: info: Mar 17 12:29:05 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:05 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:05 volumio volumio[855]: info: sendMpdCommand clear took 16 milliseconds Mar 17 12:29:05 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:05 volumio volumio[855]: info: ------------------------------ 9ms Mar 17 12:29:05 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-45.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D67b15b8f430ab976e9cb0fd26cc23349d7859ec6fbdb393b18d50858dbfe7821%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e58c62%2F0%2F12817781%2F672382e9.165902856.10.110153863%2Fflac&ext=.flac" Mar 17 12:29:05 volumio volumio[855]: info: Mar 17 12:29:05 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:05 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:05 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-45.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D67b15b8f430ab976e9cb0fd26cc23349d7859ec6fbdb393b18d50858dbfe7821%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e58c62%2F0%2F12817781%2F672382e9.165902856.10.110153863%2Fflac&ext=.flac" took 3 milliseconds Mar 17 12:29:05 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:05 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:05 volumio volumio[855]: info: Mar 17 12:29:05 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:05 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:05 volumio volumio[855]: info: ------------------------------ 4ms Mar 17 12:29:05 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:05 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:05 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:05 volumio volumio[855]: info: sendMpdCommand play took 1 milliseconds Mar 17 12:29:06 volumio volumio[855]: info: Mar 17 12:29:06 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:06 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:06 volumio volumio[855]: info: Mar 17 12:29:06 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:06 volumio volumio[855]: info: sendMpdCommand status took 29 milliseconds Mar 17 12:29:06 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:06 volumio volumio[855]: info: sendMpdCommand status took 6 milliseconds Mar 17 12:29:06 volumio volumio[855]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:06 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:06 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:06 volumio volumio[855]: info: CorePlayQueue::getTrack 2 Mar 17 12:29:06 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Field of Memories","artist":"Waterflame","album":"Age of Flash","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-45.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D67b15b8f430ab976e9cb0fd26cc23349d7859ec6fbdb393b18d50858dbfe7821%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e58c62%2F0%2F12817781%2F672382e9.165902856.10.110153863%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:06 volumio volumio[855]: verbose: CURRENT POSITION 2 Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:06 volumio volumio[855]: info: ------------------------------ 38ms Mar 17 12:29:06 volumio volumio[855]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 17 12:29:06 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:06 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:06 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:06 volumio volumio[855]: info: CorePlayQueue::getTrack 2 Mar 17 12:29:06 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":161,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Field of Memories","artist":"Waterflame","album":"Age of Flash","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-45.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D67b15b8f430ab976e9cb0fd26cc23349d7859ec6fbdb393b18d50858dbfe7821%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e58c62%2F0%2F12817781%2F672382e9.165902856.10.110153863%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:06 volumio volumio[855]: verbose: CURRENT POSITION 2 Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:06 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:06 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:06 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:06 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:06 volumio volumio[855]: info: ------------------------------ 22ms Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:06 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:06 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:06 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:06 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:06 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:06 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:06 volumio volumio[855]: info: camilladsp spawned new process with pid 20135, instance 1, run: true Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:07 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:07 volumio volumio[855]: info: Mar 17 12:29:07 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:07 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:07 volumio volumio[855]: info: Mar 17 12:29:07 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand next took 4 milliseconds Mar 17 12:29:07 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:07 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:07 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:07 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrack 2 Mar 17 12:29:07 volumio volumio[855]: 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 17 12:29:07 volumio volumio[855]: verbose: CURRENT POSITION 2 Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrack 3 Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrack 3 Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrack 3 Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:07 volumio volumio[855]: info: ------------------------------ 16ms Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrack 3 Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand stop took 16 milliseconds Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:07 volumio volumio[855]: info: Mar 17 12:29:07 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:07 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand clear took 17 milliseconds Mar 17 12:29:07 volumio volumio[855]: info: camilladsp spawned new process with pid 20142, instance 1, run: true Mar 17 12:29:07 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:07 volumio volumio[855]: info: ------------------------------ 36ms Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:07 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:07 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/10168346:1098009@user:onyourwave Mar 17 12:29:07 volumio volumio[855]: info: Exploding uri yandex_music/track/10168346:1098009@user:onyourwave in service yandex_music Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:07 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:07 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/115046268:26411652@user:onyourwave Mar 17 12:29:07 volumio volumio[855]: info: Exploding uri yandex_music/track/115046268:26411652@user:onyourwave in service yandex_music Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-std-34.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbcb8e1a9d696d6dcce48cff0adfdf85cdb4fc21f18a3458829e0e95b5144a3bf%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5350e%2F0%2F1767842%2F05310b6a.191169552.11.131973282%2Fflac&ext=.flac" Mar 17 12:29:07 volumio volumio[855]: info: Mar 17 12:29:07 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:07 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-std-34.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbcb8e1a9d696d6dcce48cff0adfdf85cdb4fc21f18a3458829e0e95b5144a3bf%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5350e%2F0%2F1767842%2F05310b6a.191169552.11.131973282%2Fflac&ext=.flac" took 2 milliseconds Mar 17 12:29:07 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:07 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:07 volumio volumio[855]: info: Mar 17 12:29:07 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:07 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:07 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:07 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand play took 11 milliseconds Mar 17 12:29:07 volumio volumio[855]: info: Mar 17 12:29:07 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:07 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:07 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:07 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:07 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:07 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:07 volumio volumio[855]: info: Mar 17 12:29:07 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand status took 21 milliseconds Mar 17 12:29:07 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:07 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrack 3 Mar 17 12:29:07 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":128,"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%2Fstrm-std-34.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbcb8e1a9d696d6dcce48cff0adfdf85cdb4fc21f18a3458829e0e95b5144a3bf%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5350e%2F0%2F1767842%2F05310b6a.191169552.11.131973282%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:07 volumio volumio[855]: verbose: CURRENT POSITION 3 Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:07 volumio volumio[855]: info: ------------------------------ 28ms Mar 17 12:29:07 volumio volumio[855]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 17 12:29:07 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:07 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getTrack 3 Mar 17 12:29:07 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":128,"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%2Fstrm-std-34.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbcb8e1a9d696d6dcce48cff0adfdf85cdb4fc21f18a3458829e0e95b5144a3bf%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5350e%2F0%2F1767842%2F05310b6a.191169552.11.131973282%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:07 volumio volumio[855]: verbose: CURRENT POSITION 3 Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:07 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:07 volumio volumio[855]: info: ------------------------------ 19ms Mar 17 12:29:07 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:07 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:07 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:07 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:08 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:08 volumio volumio[855]: info: Mar 17 12:29:08 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:08 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:08 volumio volumio[855]: info: Mar 17 12:29:08 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:08 volumio volumio[855]: info: sendMpdCommand next took 4 milliseconds Mar 17 12:29:08 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:08 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:08 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:08 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:08 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:08 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:08 volumio volumio[855]: info: CorePlayQueue::getTrack 3 Mar 17 12:29:08 volumio volumio[855]: 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 17 12:29:08 volumio volumio[855]: verbose: CURRENT POSITION 3 Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:08 volumio volumio[855]: info: CorePlayQueue::getTrack 4 Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:08 volumio volumio[855]: info: CorePlayQueue::getTrack 4 Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:08 volumio volumio[855]: info: CorePlayQueue::getTrack 4 Mar 17 12:29:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:08 volumio volumio[855]: info: ------------------------------ 15ms Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:08 volumio volumio[855]: info: CorePlayQueue::getTrack 4 Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:08 volumio volumio[855]: info: sendMpdCommand stop took 22 milliseconds Mar 17 12:29:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:08 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:08 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:08 volumio volumio[855]: info: Mar 17 12:29:08 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:08 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:08 volumio volumio[855]: info: sendMpdCommand clear took 20 milliseconds Mar 17 12:29:08 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:08 volumio volumio[855]: info: ------------------------------ 9ms Mar 17 12:29:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-84.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4c5bed53d215f22af19918e702f028c1efe4b3d12418975bef48e1c4e720d66a%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5b1ea%2F0%2F14344548%2F1a9da339.3254990.20.2542732%2Fflac&ext=.flac" Mar 17 12:29:08 volumio volumio[855]: info: Mar 17 12:29:08 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:08 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:08 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-84.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4c5bed53d215f22af19918e702f028c1efe4b3d12418975bef48e1c4e720d66a%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5b1ea%2F0%2F14344548%2F1a9da339.3254990.20.2542732%2Fflac&ext=.flac" took 2 milliseconds Mar 17 12:29:08 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:08 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:08 volumio volumio[855]: info: Mar 17 12:29:08 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:08 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:08 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:08 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:08 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:08 volumio volumio[855]: info: ------------------------------ 5ms Mar 17 12:29:08 volumio volumio[855]: info: sendMpdCommand play took 4 milliseconds Mar 17 12:29:09 volumio volumio[855]: info: camilladsp spawned new process with pid 20152, instance 1, run: true Mar 17 12:29:09 volumio volumio[855]: info: Mar 17 12:29:09 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:09 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:09 volumio volumio[855]: info: Mar 17 12:29:09 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand status took 21 milliseconds Mar 17 12:29:09 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand status took 3 milliseconds Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:09 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrack 4 Mar 17 12:29:09 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"This Is Not The Original Dream","artist":"Beautiful Sin","album":"The Unexpected","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-84.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4c5bed53d215f22af19918e702f028c1efe4b3d12418975bef48e1c4e720d66a%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5b1ea%2F0%2F14344548%2F1a9da339.3254990.20.2542732%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:09 volumio volumio[855]: verbose: CURRENT POSITION 4 Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:09 volumio volumio[855]: info: ------------------------------ 29ms Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:09 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrack 4 Mar 17 12:29:09 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"This Is Not The Original Dream","artist":"Beautiful Sin","album":"The Unexpected","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-mar-84.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D4c5bed53d215f22af19918e702f028c1efe4b3d12418975bef48e1c4e720d66a%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5b1ea%2F0%2F14344548%2F1a9da339.3254990.20.2542732%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:09 volumio volumio[855]: verbose: CURRENT POSITION 4 Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:09 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:09 volumio volumio[855]: info: ------------------------------ 20ms Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:09 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:09 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/14338463:2502638@user:onyourwave Mar 17 12:29:09 volumio volumio[855]: info: Exploding uri yandex_music/track/14338463:2502638@user:onyourwave in service yandex_music Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:09 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:09 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/48215712:6568570@user:onyourwave Mar 17 12:29:09 volumio volumio[855]: info: Exploding uri yandex_music/track/48215712:6568570@user:onyourwave in service yandex_music Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:09 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:09 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/9072466:952431@user:onyourwave Mar 17 12:29:09 volumio volumio[855]: info: Exploding uri yandex_music/track/9072466:952431@user:onyourwave in service yandex_music Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:09 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:09 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:09 volumio volumio[855]: info: Mar 17 12:29:09 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:09 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:09 volumio volumio[855]: info: Mar 17 12:29:09 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand next took 19 milliseconds Mar 17 12:29:09 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:09 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:09 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand status took 1 milliseconds Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:09 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrack 4 Mar 17 12:29:09 volumio volumio[855]: 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 17 12:29:09 volumio volumio[855]: verbose: CURRENT POSITION 4 Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrack 5 Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrack 5 Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrack 5 Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:09 volumio volumio[855]: info: ------------------------------ 16ms Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getTrack 5 Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand stop took 19 milliseconds Mar 17 12:29:09 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:09 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:09 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:09 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:09 volumio volumio[855]: info: Mar 17 12:29:09 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:09 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:09 volumio volumio[855]: info: sendMpdCommand clear took 16 milliseconds Mar 17 12:29:09 volumio volumio[855]: info: camilladsp spawned new process with pid 20163, instance 1, run: true Mar 17 12:29:09 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:09 volumio volumio[855]: info: ------------------------------ 53ms Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-171.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D53a4a17d614e1ec9a6ad39b8078442050b9f7b140103f6272e6b484a811f67fe%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e623ca%2F0%2F5228913%2F0c56380d.198796759.9.135031715%2Fflac&ext=.flac" Mar 17 12:29:10 volumio volumio[855]: info: Mar 17 12:29:10 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:10 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:10 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-171.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D53a4a17d614e1ec9a6ad39b8078442050b9f7b140103f6272e6b484a811f67fe%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e623ca%2F0%2F5228913%2F0c56380d.198796759.9.135031715%2Fflac&ext=.flac" took 2 milliseconds Mar 17 12:29:10 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:10 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:10 volumio volumio[855]: info: Mar 17 12:29:10 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:10 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:10 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:10 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:10 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:10 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:10 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/73243300:12692199@user:onyourwave Mar 17 12:29:10 volumio volumio[855]: info: Exploding uri yandex_music/track/73243300:12692199@user:onyourwave in service yandex_music Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:10 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:10 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/3652663:407363@user:onyourwave Mar 17 12:29:10 volumio volumio[855]: info: Exploding uri yandex_music/track/3652663:407363@user:onyourwave in service yandex_music Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:10 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:10 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/34550038:4259693@user:onyourwave Mar 17 12:29:10 volumio volumio[855]: info: Exploding uri yandex_music/track/34550038:4259693@user:onyourwave in service yandex_music Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:10 volumio volumio[855]: info: Mar 17 12:29:10 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:10 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:10 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:10 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:10 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:10 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:10 volumio volumio[855]: info: Mar 17 12:29:10 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:10 volumio volumio[855]: info: sendMpdCommand status took 22 milliseconds Mar 17 12:29:10 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:10 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:10 volumio volumio[855]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:10 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::getTrack 5 Mar 17 12:29:10 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":178,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Look","artist":"Bad Loverz","album":"The Look","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-171.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D53a4a17d614e1ec9a6ad39b8078442050b9f7b140103f6272e6b484a811f67fe%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e623ca%2F0%2F5228913%2F0c56380d.198796759.9.135031715%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:10 volumio volumio[855]: verbose: CURRENT POSITION 5 Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:10 volumio volumio[855]: info: ------------------------------ 28ms Mar 17 12:29:10 volumio volumio[855]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 17 12:29:10 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:10 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::getTrack 5 Mar 17 12:29:10 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":178,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"The Look","artist":"Bad Loverz","album":"The Look","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-171.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D53a4a17d614e1ec9a6ad39b8078442050b9f7b140103f6272e6b484a811f67fe%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e623ca%2F0%2F5228913%2F0c56380d.198796759.9.135031715%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:10 volumio volumio[855]: verbose: CURRENT POSITION 5 Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:10 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:10 volumio volumio[855]: info: ------------------------------ 17ms Mar 17 12:29:10 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:10 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:10 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:10 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:11 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:11 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:11 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:11 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:11 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/134184172:34518889@user:onyourwave Mar 17 12:29:11 volumio volumio[855]: info: Exploding uri yandex_music/track/134184172:34518889@user:onyourwave in service yandex_music Mar 17 12:29:11 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:11 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:11 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:11 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:14 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:14 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:14 volumio volumio[855]: info: Mar 17 12:29:14 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:14 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:14 volumio volumio[855]: info: Mar 17 12:29:14 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:14 volumio volumio[855]: info: sendMpdCommand next took 3 milliseconds Mar 17 12:29:14 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:14 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:14 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:14 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:14 volumio volumio[855]: info: sendMpdCommand status took 1 milliseconds Mar 17 12:29:14 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:14 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:14 volumio volumio[855]: info: CorePlayQueue::getTrack 5 Mar 17 12:29:14 volumio volumio[855]: 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 17 12:29:14 volumio volumio[855]: verbose: CURRENT POSITION 5 Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:14 volumio volumio[855]: info: CorePlayQueue::getTrack 6 Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:14 volumio volumio[855]: info: CorePlayQueue::getTrack 6 Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:14 volumio volumio[855]: info: CorePlayQueue::getTrack 6 Mar 17 12:29:14 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:14 volumio volumio[855]: info: ------------------------------ 17ms Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:14 volumio volumio[855]: info: CorePlayQueue::getTrack 6 Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:14 volumio volumio[855]: info: sendMpdCommand stop took 15 milliseconds Mar 17 12:29:14 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:14 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:14 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:14 volumio volumio[855]: info: Mar 17 12:29:14 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:14 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:14 volumio volumio[855]: info: sendMpdCommand clear took 373 milliseconds Mar 17 12:29:14 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:14 volumio volumio[855]: info: ------------------------------ 9ms Mar 17 12:29:14 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-113.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3De1e5d361a4357b734947af684a6e0d355af6358f7077c205c746aaf77a021dac%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5317f%2F0%2F3597558%2F090b9837.90665922.13.60975735%2Fflac&ext=.flac" Mar 17 12:29:14 volumio volumio[855]: info: Mar 17 12:29:14 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:14 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:14 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-113.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3De1e5d361a4357b734947af684a6e0d355af6358f7077c205c746aaf77a021dac%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5317f%2F0%2F3597558%2F090b9837.90665922.13.60975735%2Fflac&ext=.flac" took 3 milliseconds Mar 17 12:29:14 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:14 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:14 volumio volumio[855]: info: Mar 17 12:29:14 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:14 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:14 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:14 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:14 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:14 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:14 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:29:15 volumio volumio[855]: info: camilladsp spawned new process with pid 20188, instance 1, run: true Mar 17 12:29:15 volumio volumio[855]: info: Mar 17 12:29:15 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:15 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:15 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 48000,S32_LE,2,32 Mar 17 12:29:15 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 48000 Mar 17 12:29:15 volumio volumio[855]: info: camilladsp stopping service pid 20188... Mar 17 12:29:15 volumio volumio[855]: info: camilladsp service terminated, instance 1 Mar 17 12:29:15 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:15 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:15 volumio volumio[855]: info: camilladsp service started and running in background, instance 1 Mar 17 12:29:15 volumio volumio[855]: info: Mar 17 12:29:15 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:15 volumio volumio[855]: info: sendMpdCommand status took 62 milliseconds Mar 17 12:29:15 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:15 volumio volumio[855]: info: sendMpdCommand status took 1 milliseconds Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:15 volumio volumio[855]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 17 12:29:15 volumio volumio[855]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:15 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:15 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:15 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:15 volumio volumio[855]: info: CorePlayQueue::getTrack 6 Mar 17 12:29:15 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":180,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Triage at Dawn","artist":"Xen Machine","album":"Cybernetic Generation","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-113.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3De1e5d361a4357b734947af684a6e0d355af6358f7077c205c746aaf77a021dac%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5317f%2F0%2F3597558%2F090b9837.90665922.13.60975735%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:15 volumio volumio[855]: verbose: CURRENT POSITION 6 Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:15 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:15 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:15 volumio volumio[855]: info: CorePlayQueue::getTrack 6 Mar 17 12:29:15 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":180,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Triage at Dawn","artist":"Xen Machine","album":"Cybernetic Generation","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-113.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3De1e5d361a4357b734947af684a6e0d355af6358f7077c205c746aaf77a021dac%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5317f%2F0%2F3597558%2F090b9837.90665922.13.60975735%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:15 volumio volumio[855]: verbose: CURRENT POSITION 6 Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:15 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:15 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:15 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:15 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:15 volumio volumio[855]: info: ------------------------------ 80ms Mar 17 12:29:15 volumio volumio[855]: info: ------------------------------ 21ms Mar 17 12:29:15 volumio volumio[855]: info: camilladsp spawned new process with pid 20199, instance 1, run: true Mar 17 12:29:15 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:15 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:15 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:15 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:15 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:16 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/6095091:670433@user:onyourwave Mar 17 12:29:16 volumio volumio[855]: info: Exploding uri yandex_music/track/6095091:670433@user:onyourwave in service yandex_music Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:16 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/4004688:464605@user:onyourwave Mar 17 12:29:16 volumio volumio[855]: info: Exploding uri yandex_music/track/4004688:464605@user:onyourwave in service yandex_music Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:16 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/58855277:8973098@user:onyourwave Mar 17 12:29:16 volumio volumio[855]: info: Exploding uri yandex_music/track/58855277:8973098@user:onyourwave in service yandex_music Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:16 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:16 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/10384721:1123583@user:onyourwave Mar 17 12:29:16 volumio volumio[855]: info: Exploding uri yandex_music/track/10384721:1123583@user:onyourwave in service yandex_music Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:16 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:16 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:16 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:19 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:19 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:19 volumio volumio[855]: info: Mar 17 12:29:19 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:19 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:19 volumio volumio[855]: info: Mar 17 12:29:19 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:19 volumio volumio[855]: info: sendMpdCommand next took 3 milliseconds Mar 17 12:29:19 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:19 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:19 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:19 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:19 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:19 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:19 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:19 volumio volumio[855]: info: CorePlayQueue::getTrack 6 Mar 17 12:29:19 volumio volumio[855]: 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 17 12:29:19 volumio volumio[855]: verbose: CURRENT POSITION 6 Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:19 volumio volumio[855]: info: CorePlayQueue::getTrack 7 Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:19 volumio volumio[855]: info: CorePlayQueue::getTrack 7 Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:19 volumio volumio[855]: info: CorePlayQueue::getTrack 7 Mar 17 12:29:19 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:19 volumio volumio[855]: info: ------------------------------ 17ms Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:19 volumio volumio[855]: info: CorePlayQueue::getTrack 7 Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:19 volumio volumio[855]: info: sendMpdCommand stop took 13 milliseconds Mar 17 12:29:19 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:19 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:19 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:19 volumio volumio[855]: info: Mar 17 12:29:19 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:19 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:19 volumio volumio[855]: info: sendMpdCommand clear took 13 milliseconds Mar 17 12:29:19 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:19 volumio volumio[855]: info: ------------------------------ 8ms Mar 17 12:29:19 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-30.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f8bb187a2bed5d4ed1b46942c758add3317d5b120d75f0c2367bdea605bc9c8%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5f431%2F0%2F6420343%2Fca845e8f.199298244.10.135500237%2Fflac&ext=.flac" Mar 17 12:29:19 volumio volumio[855]: info: Mar 17 12:29:19 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:19 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:19 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-30.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f8bb187a2bed5d4ed1b46942c758add3317d5b120d75f0c2367bdea605bc9c8%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5f431%2F0%2F6420343%2Fca845e8f.199298244.10.135500237%2Fflac&ext=.flac" took 2 milliseconds Mar 17 12:29:19 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:19 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:19 volumio volumio[855]: info: Mar 17 12:29:19 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:19 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:19 volumio volumio[855]: info: ------------------------------ 4ms Mar 17 12:29:19 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:19 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:19 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:19 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:29:20 volumio volumio[855]: info: camilladsp spawned new process with pid 20207, instance 1, run: true Mar 17 12:29:20 volumio volumio[855]: info: Mar 17 12:29:20 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:20 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:20 volumio volumio[855]: info: camilladsp stopping service pid 20207... Mar 17 12:29:20 volumio volumio[855]: info: camilladsp service terminated, instance 1 Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:20 volumio volumio[855]: info: camilladsp service started and running in background, instance 1 Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:20 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:20 volumio volumio[855]: info: Mar 17 12:29:20 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:20 volumio volumio[855]: info: sendMpdCommand status took 95 milliseconds Mar 17 12:29:20 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:20 volumio volumio[855]: info: sendMpdCommand status took 11 milliseconds Mar 17 12:29:20 volumio volumio[855]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:20 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:20 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:20 volumio volumio[855]: info: CorePlayQueue::getTrack 7 Mar 17 12:29:20 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Love","artist":"Omnia, Armin Van Buuren","album":"Love","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-30.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f8bb187a2bed5d4ed1b46942c758add3317d5b120d75f0c2367bdea605bc9c8%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5f431%2F0%2F6420343%2Fca845e8f.199298244.10.135500237%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:20 volumio volumio[855]: verbose: CURRENT POSITION 7 Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:20 volumio volumio[855]: info: ------------------------------ 111ms Mar 17 12:29:20 volumio volumio[855]: info: camilladsp spawned new process with pid 20232, instance 1, run: true Mar 17 12:29:20 volumio volumio[855]: info: sendMpdCommand playlistinfo took 29 milliseconds Mar 17 12:29:20 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:20 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:20 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:20 volumio volumio[855]: info: CorePlayQueue::getTrack 7 Mar 17 12:29:20 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":328,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Love","artist":"Omnia, Armin Van Buuren","album":"Love","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2Fstrm-m9-30.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3f8bb187a2bed5d4ed1b46942c758add3317d5b120d75f0c2367bdea605bc9c8%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5f431%2F0%2F6420343%2Fca845e8f.199298244.10.135500237%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:20 volumio volumio[855]: verbose: CURRENT POSITION 7 Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:20 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:20 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:20 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:20 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:20 volumio volumio[855]: info: ------------------------------ 56ms Mar 17 12:29:20 volumio volumio[855]: error: FusionDsp - WebSocket error: [object Object] Mar 17 12:29:20 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:20 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:20 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:20 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:20 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:21 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:21 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:21 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:21 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:21 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/58894562:8983830@user:onyourwave Mar 17 12:29:21 volumio volumio[855]: info: Exploding uri yandex_music/track/58894562:8983830@user:onyourwave in service yandex_music Mar 17 12:29:21 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:21 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:21 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:21 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:22 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:22 volumio volumio[855]: info: Mar 17 12:29:22 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:22 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:22 volumio volumio[855]: info: Mar 17 12:29:22 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand next took 4 milliseconds Mar 17 12:29:22 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:22 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:22 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:22 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getTrack 7 Mar 17 12:29:22 volumio volumio[855]: 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 17 12:29:22 volumio volumio[855]: verbose: CURRENT POSITION 7 Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getTrack 8 Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getTrack 8 Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getTrack 8 Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:22 volumio volumio[855]: info: ------------------------------ 14ms Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getTrack 8 Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand stop took 13 milliseconds Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:22 volumio volumio[855]: info: Mar 17 12:29:22 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:22 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand clear took 15 milliseconds Mar 17 12:29:22 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:22 volumio volumio[855]: info: ------------------------------ 9ms Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D79ad391a03d6b1bc1031ef97484684d0d8210eb3f734388bd46d3141740e8ee4%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e61f80%2F0%2F4239870%2F2c2f1d56.106757073.21.70904052%2Fflac&ext=.flac" Mar 17 12:29:22 volumio volumio[855]: info: Mar 17 12:29:22 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:22 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D79ad391a03d6b1bc1031ef97484684d0d8210eb3f734388bd46d3141740e8ee4%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e61f80%2F0%2F4239870%2F2c2f1d56.106757073.21.70904052%2Fflac&ext=.flac" took 3 milliseconds Mar 17 12:29:22 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:22 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:22 volumio volumio[855]: info: Mar 17 12:29:22 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:22 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:22 volumio volumio[855]: info: ------------------------------ 10ms Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:22 volumio volumio[855]: info: ------------------------------ 12ms Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand play took 4 milliseconds Mar 17 12:29:22 volumio volumio[855]: info: Mar 17 12:29:22 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:22 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:22 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:22 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:22 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:22 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:22 volumio volumio[855]: info: Mar 17 12:29:22 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand status took 14 milliseconds Mar 17 12:29:22 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:22 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getTrack 8 Mar 17 12:29:22 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":140,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Main Title (From Doctor Who, 1963)","artist":"Ron Grainer","album":"Best RON GRAINER Early Movie Themes","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D79ad391a03d6b1bc1031ef97484684d0d8210eb3f734388bd46d3141740e8ee4%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e61f80%2F0%2F4239870%2F2c2f1d56.106757073.21.70904052%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:22 volumio volumio[855]: verbose: CURRENT POSITION 8 Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:22 volumio volumio[855]: info: ------------------------------ 19ms Mar 17 12:29:22 volumio volumio[855]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 17 12:29:22 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:22 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getTrack 8 Mar 17 12:29:22 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":140,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Main Title (From Doctor Who, 1963)","artist":"Ron Grainer","album":"Best RON GRAINER Early Movie Themes","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1528.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D79ad391a03d6b1bc1031ef97484684d0d8210eb3f734388bd46d3141740e8ee4%2Clid%3D1528%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e61f80%2F0%2F4239870%2F2c2f1d56.106757073.21.70904052%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:22 volumio volumio[855]: verbose: CURRENT POSITION 8 Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:22 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:22 volumio volumio[855]: info: ------------------------------ 17ms Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:22 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:22 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:22 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:22 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:22 volumio volumio[855]: info: camilladsp spawned new process with pid 20242, instance 1, run: true Mar 17 12:29:23 volumio volumio[855]: info: CoreCommandRouter::volumioAddQueueItems Mar 17 12:29:23 volumio volumio[855]: info: CoreStateMachine::addQueueItems Mar 17 12:29:23 volumio volumio[855]: info: CorePlayQueue::addQueueItems Mar 17 12:29:23 volumio volumio[855]: info: Preload queue cleared Mar 17 12:29:23 volumio volumio[855]: info: Adding Item to queue: yandex_music/track/117063160:27238551@user:onyourwave Mar 17 12:29:23 volumio volumio[855]: info: Exploding uri yandex_music/track/117063160:27238551@user:onyourwave in service yandex_music Mar 17 12:29:23 volumio volumio[855]: info: CoreCommandRouter::volumioPushQueue Mar 17 12:29:23 volumio volumio[855]: info: CorePlayQueue::saveQueue Mar 17 12:29:23 volumio volumio[855]: info: CoreStateMachine::updateTrackBlock Mar 17 12:29:23 volumio volumio[855]: info: CorePlayQueue::getTrackBlock Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:26 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:26 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:26 volumio volumio[855]: info: Mar 17 12:29:26 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:26 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:26 volumio volumio[855]: info: Mar 17 12:29:26 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:26 volumio volumio[855]: info: sendMpdCommand next took 4 milliseconds Mar 17 12:29:26 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:26 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:26 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:26 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:26 volumio volumio[855]: info: sendMpdCommand status took 1 milliseconds Mar 17 12:29:26 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:26 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:26 volumio volumio[855]: info: CorePlayQueue::getTrack 8 Mar 17 12:29:26 volumio volumio[855]: 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 17 12:29:26 volumio volumio[855]: verbose: CURRENT POSITION 8 Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:26 volumio volumio[855]: info: CorePlayQueue::getTrack 9 Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:26 volumio volumio[855]: info: CorePlayQueue::getTrack 9 Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:26 volumio volumio[855]: info: CorePlayQueue::getTrack 9 Mar 17 12:29:26 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:26 volumio volumio[855]: info: ------------------------------ 14ms Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:26 volumio volumio[855]: info: CorePlayQueue::getTrack 9 Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:26 volumio volumio[855]: info: sendMpdCommand stop took 13 milliseconds Mar 17 12:29:26 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:26 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:26 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:26 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:26 volumio volumio[855]: info: Mar 17 12:29:26 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:26 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:26 volumio volumio[855]: info: sendMpdCommand clear took 16 milliseconds Mar 17 12:29:26 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:26 volumio volumio[855]: info: ------------------------------ 9ms Mar 17 12:29:27 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0ec97ada18a68f765e581787e6ba545928aeea02a59fddfaf41724d4113bb348%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e56f8d%2F33371%2F21201%2Fc1cea188.1722447.12.1296551%2F320.mp3&ext=.mp3" Mar 17 12:29:27 volumio volumio[855]: info: Mar 17 12:29:27 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:27 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:27 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0ec97ada18a68f765e581787e6ba545928aeea02a59fddfaf41724d4113bb348%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e56f8d%2F33371%2F21201%2Fc1cea188.1722447.12.1296551%2F320.mp3&ext=.mp3" took 2 milliseconds Mar 17 12:29:27 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:27 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:27 volumio volumio[855]: info: Mar 17 12:29:27 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:27 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:27 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:27 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:27 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:27 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:27 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:29:27 volumio volumio[855]: info: camilladsp spawned new process with pid 20253, instance 1, run: true Mar 17 12:29:28 volumio volumio[855]: info: Mar 17 12:29:28 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:28 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:28 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:28 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:28 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:28 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:28 volumio volumio[855]: info: Mar 17 12:29:28 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:28 volumio volumio[855]: info: sendMpdCommand status took 17 milliseconds Mar 17 12:29:28 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:28 volumio volumio[855]: info: sendMpdCommand status took 5 milliseconds Mar 17 12:29:28 volumio volumio[855]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:28 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:28 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:28 volumio volumio[855]: info: CorePlayQueue::getTrack 9 Mar 17 12:29:28 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":213,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sick And Tired","artist":"Valeria","album":"A Tribute To Anastacia","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0ec97ada18a68f765e581787e6ba545928aeea02a59fddfaf41724d4113bb348%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e56f8d%2F33371%2F21201%2Fc1cea188.1722447.12.1296551%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 17 12:29:28 volumio volumio[855]: verbose: CURRENT POSITION 9 Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:28 volumio volumio[855]: info: ------------------------------ 32ms Mar 17 12:29:28 volumio volumio[855]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 17 12:29:28 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:28 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:28 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:28 volumio volumio[855]: info: CorePlayQueue::getTrack 9 Mar 17 12:29:28 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1234,"duration":213,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Sick And Tired","artist":"Valeria","album":"A Tribute To Anastacia","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D0ec97ada18a68f765e581787e6ba545928aeea02a59fddfaf41724d4113bb348%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e56f8d%2F33371%2F21201%2Fc1cea188.1722447.12.1296551%2F320.mp3&ext=.mp3","trackType":"mp3"} Mar 17 12:29:28 volumio volumio[855]: verbose: CURRENT POSITION 9 Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:28 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:28 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:28 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:28 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:28 volumio volumio[855]: info: ------------------------------ 27ms Mar 17 12:29:28 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:28 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:28 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:28 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:28 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:28 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:31 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:31 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:31 volumio volumio[855]: info: Mar 17 12:29:31 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:31 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:31 volumio volumio[855]: info: Mar 17 12:29:31 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:31 volumio volumio[855]: info: sendMpdCommand next took 4 milliseconds Mar 17 12:29:31 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:31 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:31 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:31 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:31 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:31 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:31 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:31 volumio volumio[855]: info: CorePlayQueue::getTrack 9 Mar 17 12:29:31 volumio volumio[855]: 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 17 12:29:31 volumio volumio[855]: verbose: CURRENT POSITION 9 Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:31 volumio volumio[855]: info: CorePlayQueue::getTrack 10 Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:31 volumio volumio[855]: info: CorePlayQueue::getTrack 10 Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:31 volumio volumio[855]: info: CorePlayQueue::getTrack 10 Mar 17 12:29:31 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:31 volumio volumio[855]: info: ------------------------------ 17ms Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:31 volumio volumio[855]: info: CorePlayQueue::getTrack 10 Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:31 volumio volumio[855]: info: sendMpdCommand stop took 13 milliseconds Mar 17 12:29:31 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:31 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:31 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:31 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:31 volumio volumio[855]: info: Mar 17 12:29:31 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:31 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:31 volumio volumio[855]: info: sendMpdCommand clear took 18 milliseconds Mar 17 12:29:31 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:31 volumio volumio[855]: info: ------------------------------ 10ms Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbe9ae2fc4b41688e02c932d959666f282111d785f3f29d49a3cbc53b5c69aa5b%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e50e39%2F0%2F399577%2F5d6c7b55.190303609.7.131482632%2Fflac&ext=.flac" Mar 17 12:29:32 volumio volumio[855]: info: Mar 17 12:29:32 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:32 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:32 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbe9ae2fc4b41688e02c932d959666f282111d785f3f29d49a3cbc53b5c69aa5b%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e50e39%2F0%2F399577%2F5d6c7b55.190303609.7.131482632%2Fflac&ext=.flac" took 3 milliseconds Mar 17 12:29:32 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:32 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:32 volumio volumio[855]: info: Mar 17 12:29:32 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:32 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:32 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:32 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:32 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:29:32 volumio volumio[855]: info: Mar 17 12:29:32 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:32 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - ---- read samplerate from file: 44100 Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - If filter freq >samplerate/2 then disable it Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - Nulleq applied Mar 17 12:29:32 volumio volumio[855]: info: Mar 17 12:29:32 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:32 volumio volumio[855]: info: sendMpdCommand status took 29 milliseconds Mar 17 12:29:32 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:32 volumio volumio[855]: info: sendMpdCommand status took 4 milliseconds Mar 17 12:29:32 volumio volumio[855]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:32 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:32 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:32 volumio volumio[855]: info: CorePlayQueue::getTrack 10 Mar 17 12:29:32 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Deltaplane","artist":"Paraskeva","album":"Burning Scapes","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbe9ae2fc4b41688e02c932d959666f282111d785f3f29d49a3cbc53b5c69aa5b%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e50e39%2F0%2F399577%2F5d6c7b55.190303609.7.131482632%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:32 volumio volumio[855]: verbose: CURRENT POSITION 10 Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:32 volumio volumio[855]: info: ------------------------------ 38ms Mar 17 12:29:32 volumio volumio[855]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 17 12:29:32 volumio volumio[855]: verbose: ControllerMpd::parseTrackInfo Mar 17 12:29:32 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:32 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:32 volumio volumio[855]: info: CorePlayQueue::getTrack 10 Mar 17 12:29:32 volumio volumio[855]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":288,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Deltaplane","artist":"Paraskeva","album":"Burning Scapes","uri":"http://localhost:6601/?codec=flac&url=https%3A%2F%2F1559.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbe9ae2fc4b41688e02c932d959666f282111d785f3f29d49a3cbc53b5c69aa5b%2Clid%3D1559%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e50e39%2F0%2F399577%2F5d6c7b55.190303609.7.131482632%2Fflac&ext=.flac","trackType":"flac"} Mar 17 12:29:32 volumio volumio[855]: verbose: CURRENT POSITION 10 Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::syncState stateService play Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:32 volumio volumio[855]: info: Received an update from plugin. extracting info from payload Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:32 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:32 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:32 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:32 volumio volumio[855]: info: ------------------------------ 21ms Mar 17 12:29:32 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:32 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:32 volumio volumio[855]: info: CoreCommandRouter::volumioGetQueue Mar 17 12:29:32 volumio volumio[855]: info: CoreStateMachine::getQueue Mar 17 12:29:32 volumio volumio[855]: info: CorePlayQueue::getQueue Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:32 volumio volumio[855]: info: FusionDsp - {"Reload":{"result":"Ok"}} Mar 17 12:29:32 volumio volumio[855]: info: camilladsp spawned new process with pid 20282, instance 1, run: true Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:35 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:35 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:35 volumio volumio[855]: info: Mar 17 12:29:35 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:35 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:35 volumio volumio[855]: info: Mar 17 12:29:35 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:35 volumio volumio[855]: info: sendMpdCommand next took 7 milliseconds Mar 17 12:29:35 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:35 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:35 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:35 volumio volumio[855]: info: ------------------------------ 4ms Mar 17 12:29:35 volumio volumio[855]: info: sendMpdCommand status took 2 milliseconds Mar 17 12:29:35 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:35 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:35 volumio volumio[855]: info: CorePlayQueue::getTrack 10 Mar 17 12:29:35 volumio volumio[855]: 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 17 12:29:35 volumio volumio[855]: verbose: CURRENT POSITION 10 Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus play Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::play index undefined Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:35 volumio volumio[855]: info: CorePlayQueue::getTrack 11 Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:35 volumio volumio[855]: info: CorePlayQueue::getTrack 11 Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::startPlaybackTimer Mar 17 12:29:35 volumio volumio[855]: info: CorePlayQueue::getTrack 11 Mar 17 12:29:35 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand stop Mar 17 12:29:35 volumio volumio[855]: info: ------------------------------ 21ms Mar 17 12:29:35 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:35 volumio volumio[855]: info: CorePlayQueue::getTrack 11 Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:35 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:35 volumio volumio[855]: info: sendMpdCommand stop took 14 milliseconds Mar 17 12:29:35 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand clear Mar 17 12:29:35 volumio volumio[855]: info: Mar 17 12:29:35 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:35 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:35 volumio volumio[855]: info: sendMpdCommand clear took 5 milliseconds Mar 17 12:29:35 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:35 volumio volumio[855]: info: ------------------------------ 9ms Mar 17 12:29:36 volumio volumio[855]: info: camilladsp spawned new process with pid 20289, instance 1, run: true Mar 17 12:29:38 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1537.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D7beb2318e39906981099fe49424292b9f2fdba3f2af82ca6a6ca69bc2074a5e6%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5ee2f%2F50355%2F2780339%2F77529f59.12216794.10.9529445%2F320.mp3&ext=.mp3" Mar 17 12:29:38 volumio volumio[855]: info: Mar 17 12:29:38 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:38 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:38 volumio volumio[855]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F1537.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D7beb2318e39906981099fe49424292b9f2fdba3f2af82ca6a6ca69bc2074a5e6%2Clid%3D1537%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D67e5ee2f%2F50355%2F2780339%2F77529f59.12216794.10.9529445%2F320.mp3&ext=.mp3" took 2 milliseconds Mar 17 12:29:38 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:38 volumio volumio[855]: verbose: MPD COMMAND [object Object] Mar 17 12:29:38 volumio volumio[855]: info: Mar 17 12:29:38 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:38 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:38 volumio volumio[855]: info: ------------------------------ 3ms Mar 17 12:29:38 volumio volumio[855]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 17 12:29:38 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand play Mar 17 12:29:38 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:38 volumio volumio[855]: info: sendMpdCommand play took 2 milliseconds Mar 17 12:29:39 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:39 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:39 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:39 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:39 volumio volumio[855]: info: Mar 17 12:29:39 volumio volumio[855]: ---------------------------- MPD announces system playlist update Mar 17 12:29:39 volumio volumio[855]: info: Ignoring MPD Status Update Mar 17 12:29:39 volumio volumio[855]: info: Mar 17 12:29:39 volumio volumio[855]: ---------------------------- MPD announces state update: player Mar 17 12:29:39 volumio volumio[855]: info: sendMpdCommand next took 2 milliseconds Mar 17 12:29:39 volumio volumio[855]: info: ControllerMpd::getState Mar 17 12:29:39 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand status Mar 17 12:29:39 volumio volumio[855]: error: updateQueue error: null Mar 17 12:29:39 volumio volumio[855]: info: ------------------------------ 2ms Mar 17 12:29:39 volumio volumio[855]: info: sendMpdCommand status took 1 milliseconds Mar 17 12:29:39 volumio volumio[855]: verbose: ControllerMpd::parseState Mar 17 12:29:39 volumio volumio[855]: info: ControllerMpd::pushState Mar 17 12:29:39 volumio volumio[855]: info: CoreCommandRouter::servicePushState Mar 17 12:29:39 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:39 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 17 12:29:39 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:39 volumio volumio[855]: info: CorePlayQueue::getTrack 11 Mar 17 12:29:39 volumio volumio[855]: 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 17 12:29:39 volumio volumio[855]: verbose: CURRENT POSITION 11 Mar 17 12:29:39 volumio volumio[855]: info: CoreStateMachine::syncState stateService stop Mar 17 12:29:39 volumio volumio[855]: info: CoreStateMachine::syncState currentStatus stop Mar 17 12:29:39 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:39 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:39 volumio volumio[855]: info: No code Mar 17 12:29:39 volumio volumio[855]: info: CoreStateMachine::pushState Mar 17 12:29:39 volumio volumio[855]: info: CoreCommandRouter::volumioPushState Mar 17 12:29:39 volumio volumio[855]: info: ------------------------------ 13ms Mar 17 12:29:42 volumio volumio[855]: info: CoreCommandRouter::volumioNext Mar 17 12:29:42 volumio volumio[855]: info: CoreStateMachine::next Mar 17 12:29:42 volumio volumio[855]: info: ControllerMpd::next Mar 17 12:29:42 volumio volumio[855]: verbose: ControllerMpd::sendMpdCommand next Mar 17 12:29:43 volumio volumio[855]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 17 12:29:43 volumio volumio[855]: Error: read ECONNRESET Mar 17 12:29:43 volumio volumio[855]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Mar 17 12:29:43 volumio volumio[855]: errno: -104, Mar 17 12:29:43 volumio volumio[855]: code: 'ECONNRESET', Mar 17 12:29:43 volumio volumio[855]: syscall: 'read' Mar 17 12:29:43 volumio volumio[855]: } Mar 17 12:29:43 volumio volumio[855]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 17 12:29:44 volumio sudo[20320]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-17 12:28 Mar 17 12:29:44 volumio sudo[20320]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"