-- Logs begin at Thu 2019-02-14 13:11:58 MSK, end at Sun 2025-04-20 20:58:46 MSK. -- Apr 20 20:57:01 volumio go-librespot[1323]: time="2025-04-20T20:57:01+03:00" level=trace msg="sent dealer ping" Apr 20 20:57:01 volumio go-librespot[1323]: time="2025-04-20T20:57:01+03:00" level=trace msg="received dealer pong" Apr 20 20:57:03 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:03 volumio volumio[1001]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::ClearQueue Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::stPlaybackTimer Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:57:03 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:03 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:03 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:03 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::serviceStop Apr 20 20:57:03 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:03 volumio volumio[1001]: info: CoreCommandRouter::serviceStop Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:57:03 volumio volumio[1001]: info: ControllerMpd::stop Apr 20 20:57:03 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:57:03 volumio volumio[1001]: info: CorePlayQueue::clearPlayQueue Apr 20 20:57:03 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:03 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:03 volumio volumio[1001]: info: CoreStateMachine::addQueueItems Apr 20 20:57:03 volumio volumio[1001]: info: CorePlayQueue::addQueueItems Apr 20 20:57:03 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:03 volumio volumio[1001]: info: Adding Item to queue: yandex_music/album/27412699 Apr 20 20:57:03 volumio volumio[1001]: info: Exploding uri yandex_music/album/27412699 in service yandex_music Apr 20 20:57:03 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:04 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:57:04 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:57:04 volumio volumio[1001]: info: CoreCommandRouter::volumioPlay Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::play index 0 Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:04 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:57:04 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:57:04 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand stop took 24 milliseconds Apr 20 20:57:04 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand stop took 11 milliseconds Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:04 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:04 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand status took 29 milliseconds Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand clear took 28 milliseconds Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand status took 27 milliseconds Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:04 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:04 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:04 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:04 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:04 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:04 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:04 volumio volumio[1001]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 39ms Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:04 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:04 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 21ms Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 19 milliseconds Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:04 volumio volumio[1001]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 52ms Apr 20 20:57:04 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:04 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D50db9b88ec7fb841ae3b2f051be66c5bae931760217d25e49c567228a95ad2b0%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812de23%2F29371%2F10415135%2F34ec073d.173307500.6.117450391%2F320.mp3&ext=.mp3" Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:04 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D50db9b88ec7fb841ae3b2f051be66c5bae931760217d25e49c567228a95ad2b0%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812de23%2F29371%2F10415135%2F34ec073d.173307500.6.117450391%2F320.mp3&ext=.mp3" took 2 milliseconds Apr 20 20:57:04 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:04 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:04 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 14ms Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:57:04 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:57:04 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:57:04 volumio volumio[1001]: info: Apr 20 20:57:04 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:04 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 4ms Apr 20 20:57:04 volumio volumio[1001]: info: sendMpdCommand play took 4 milliseconds Apr 20 20:57:04 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:57:06 volumio volumio[1001]: info: Apr 20 20:57:06 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:06 volumio volumio[1001]: info: Apr 20 20:57:06 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:06 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:57:06 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:57:06 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:57:06 volumio volumio[1001]: info: Apr 20 20:57:06 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:06 volumio volumio[1001]: info: sendMpdCommand status took 16 milliseconds Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:06 volumio volumio[1001]: info: sendMpdCommand status took 16 milliseconds Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:06 volumio volumio[1001]: info: Apr 20 20:57:06 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:06 volumio volumio[1001]: info: sendMpdCommand status took 4 milliseconds Apr 20 20:57:06 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:06 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":187,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Hyolyn","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D50db9b88ec7fb841ae3b2f051be66c5bae931760217d25e49c567228a95ad2b0%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812de23%2F29371%2F10415135%2F34ec073d.173307500.6.117450391%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:06 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:06 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":187,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Hyolyn","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D50db9b88ec7fb841ae3b2f051be66c5bae931760217d25e49c567228a95ad2b0%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812de23%2F29371%2F10415135%2F34ec073d.173307500.6.117450391%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:06 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:06 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:06 volumio volumio[1001]: info: ------------------------------ 27ms Apr 20 20:57:06 volumio volumio[1001]: info: ------------------------------ 29ms Apr 20 20:57:06 volumio volumio[1001]: info: sendMpdCommand status took 12 milliseconds Apr 20 20:57:06 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:06 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1512,"duration":187,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Hyolyn","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D50db9b88ec7fb841ae3b2f051be66c5bae931760217d25e49c567228a95ad2b0%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812de23%2F29371%2F10415135%2F34ec073d.173307500.6.117450391%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:06 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:06 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:06 volumio volumio[1001]: info: ------------------------------ 33ms Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:06 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:06 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:06 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:06 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:06 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 110 milliseconds Apr 20 20:57:06 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:06 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:06 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":187,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Hyolyn","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D50db9b88ec7fb841ae3b2f051be66c5bae931760217d25e49c567228a95ad2b0%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812de23%2F29371%2F10415135%2F34ec073d.173307500.6.117450391%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:06 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:06 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:06 volumio volumio[1001]: info: ------------------------------ 134ms Apr 20 20:57:06 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:06 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:06 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:06 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:06 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:06 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:57:15 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::ClearQueue Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::stPlaybackTimer Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::serviceStop Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::serviceStop Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:57:15 volumio volumio[1001]: info: ControllerMpd::stop Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::clearPlayQueue Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::addQueueItems Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::addQueueItems Apr 20 20:57:15 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:15 volumio volumio[1001]: info: Adding Item to queue: yandex_music/track/458529:61622 Apr 20 20:57:15 volumio volumio[1001]: info: Using cached record of: yandex_music/track/458529:61622 Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::volumioPlay Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::play index 0 Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:57:15 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand stop took 22 milliseconds Apr 20 20:57:15 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand stop took 10 milliseconds Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand clear took 1 milliseconds Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:15 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:15 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 36ms Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 35 milliseconds Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand status took 27 milliseconds Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:15 volumio volumio[1001]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Apr 20 20:57:15 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:15 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:15 volumio volumio[1001]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 46ms Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 39ms Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:15 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:15 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:15 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-ufa09.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddd6ca9a7209d77fa3bdbb83252460cd7bb1d875d22aaac064abfbb2f393e7db6%2Clid%3D1569%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D681346fe%2F0%2F1771652%2Fa4771f85.196171970.7.458529%2F320.mp3&ext=.mp3" Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-ufa09.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddd6ca9a7209d77fa3bdbb83252460cd7bb1d875d22aaac064abfbb2f393e7db6%2Clid%3D1569%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D681346fe%2F0%2F1771652%2Fa4771f85.196171970.7.458529%2F320.mp3&ext=.mp3" took 1 milliseconds Apr 20 20:57:15 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:57:15 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:57:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:57:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:57:15 volumio volumio[1001]: info: Apr 20 20:57:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:15 volumio volumio[1001]: info: sendMpdCommand play took 2 milliseconds Apr 20 20:57:15 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:16 volumio volumio[1001]: info: Apr 20 20:57:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:16 volumio volumio[1001]: info: Apr 20 20:57:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:16 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:57:16 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:57:16 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:57:16 volumio volumio[1001]: info: Apr 20 20:57:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand status took 21 milliseconds Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand status took 19 milliseconds Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:16 volumio volumio[1001]: info: Apr 20 20:57:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand status took 4 milliseconds Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 4 milliseconds Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 5 milliseconds Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand status took 3 milliseconds Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":225,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take on Me","artist":"a-ha","album":"The Singles: 1984-2004","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-ufa09.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddd6ca9a7209d77fa3bdbb83252460cd7bb1d875d22aaac064abfbb2f393e7db6%2Clid%3D1569%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D681346fe%2F0%2F1771652%2Fa4771f85.196171970.7.458529%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":228,"duration":225,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take on Me","artist":"a-ha","album":"The Singles: 1984-2004","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-ufa09.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddd6ca9a7209d77fa3bdbb83252460cd7bb1d875d22aaac064abfbb2f393e7db6%2Clid%3D1569%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D681346fe%2F0%2F1771652%2Fa4771f85.196171970.7.458529%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:16 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:16 volumio volumio[1001]: info: ------------------------------ 33ms Apr 20 20:57:16 volumio volumio[1001]: info: ------------------------------ 38ms Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 20 20:57:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:16 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1386,"duration":225,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take on Me","artist":"a-ha","album":"The Singles: 1984-2004","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-ufa09.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddd6ca9a7209d77fa3bdbb83252460cd7bb1d875d22aaac064abfbb2f393e7db6%2Clid%3D1569%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D681346fe%2F0%2F1771652%2Fa4771f85.196171970.7.458529%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:16 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1386,"duration":225,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take on Me","artist":"a-ha","album":"The Singles: 1984-2004","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fext-strm-ufa09.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Ddd6ca9a7209d77fa3bdbb83252460cd7bb1d875d22aaac064abfbb2f393e7db6%2Clid%3D1569%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D681346fe%2F0%2F1771652%2Fa4771f85.196171970.7.458529%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:16 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:16 volumio volumio[1001]: info: ------------------------------ 58ms Apr 20 20:57:16 volumio volumio[1001]: info: ------------------------------ 57ms Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:16 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:57:16 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:57:26 volumio go-librespot[1323]: time="2025-04-20T20:57:26+03:00" level=trace msg="received accesspoint ping" Apr 20 20:57:26 volumio go-librespot[1323]: time="2025-04-20T20:57:26+03:00" level=trace msg="received accesspoint pong ack" Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::volumioNext Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::next Apr 20 20:57:27 volumio volumio[1001]: info: ControllerMpd::next Apr 20 20:57:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand next Apr 20 20:57:27 volumio volumio[1001]: info: sendMpdCommand next took 4 milliseconds Apr 20 20:57:27 volumio volumio[1001]: info: Apr 20 20:57:27 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:27 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:27 volumio volumio[1001]: info: Apr 20 20:57:27 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:27 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:27 volumio volumio[1001]: info: Apr 20 20:57:27 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:27 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:27 volumio volumio[1001]: info: Apr 20 20:57:27 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:27 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:27 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:27 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:27 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:57:27 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:57:27 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:27 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:27 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:27 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:27 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:57:27 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::stPlaybackTimer Apr 20 20:57:27 volumio volumio[1001]: info: ------------------------------ 12ms Apr 20 20:57:27 volumio volumio[1001]: info: sendMpdCommand status took 11 milliseconds Apr 20 20:57:27 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:27 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:27 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:27 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:57:27 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:27 volumio volumio[1001]: info: No code Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:27 volumio volumio[1001]: info: ------------------------------ 29ms Apr 20 20:57:27 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:27 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:27 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:27 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:57:29 volumio volumio[1001]: info: peppy_screensaver: Start PeppyMeter Apr 20 20:57:31 volumio go-librespot[1323]: time="2025-04-20T20:57:31+03:00" level=trace msg="sent dealer ping" Apr 20 20:57:31 volumio go-librespot[1323]: time="2025-04-20T20:57:31+03:00" level=trace msg="received dealer pong" Apr 20 20:57:46 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:46 volumio volumio[1001]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::ClearQueue Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:46 volumio volumio[1001]: info: CorePlayQueue::clearPlayQueue Apr 20 20:57:46 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:46 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::addQueueItems Apr 20 20:57:46 volumio volumio[1001]: info: CorePlayQueue::addQueueItems Apr 20 20:57:46 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:46 volumio volumio[1001]: info: Adding Item to queue: yandex_music/album/8291046 Apr 20 20:57:46 volumio volumio[1001]: info: Exploding uri yandex_music/album/8291046 in service yandex_music Apr 20 20:57:46 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:46 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:57:46 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:57:46 volumio volumio[1001]: info: CoreCommandRouter::volumioPlay Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::play index 0 Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:46 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:57:46 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:46 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:57:46 volumio volumio[1001]: info: sendMpdCommand stop took 3 milliseconds Apr 20 20:57:46 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:57:46 volumio volumio[1001]: info: Apr 20 20:57:46 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:46 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:46 volumio volumio[1001]: info: sendMpdCommand clear took 1 milliseconds Apr 20 20:57:46 volumio volumio[1001]: info: Apr 20 20:57:46 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:46 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:46 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:46 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:46 volumio volumio[1001]: info: ------------------------------ 5ms Apr 20 20:57:46 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:57:46 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3" Apr 20 20:57:46 volumio volumio[1001]: info: Apr 20 20:57:46 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:46 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:46 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3" took 2 milliseconds Apr 20 20:57:46 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:57:46 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:57:46 volumio volumio[1001]: info: Apr 20 20:57:46 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:46 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:46 volumio volumio[1001]: info: Apr 20 20:57:46 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:46 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:46 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:46 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:57:46 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:57:46 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:57:46 volumio volumio[1001]: info: Apr 20 20:57:46 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:46 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:46 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:46 volumio volumio[1001]: info: sendMpdCommand play took 2 milliseconds Apr 20 20:57:46 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:47 volumio volumio[1001]: info: Apr 20 20:57:47 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:47 volumio volumio[1001]: info: Apr 20 20:57:47 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:57:47 volumio volumio[1001]: info: Apr 20 20:57:47 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand status took 24 milliseconds Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand status took 23 milliseconds Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:47 volumio volumio[1001]: info: Apr 20 20:57:47 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand status took 3 milliseconds Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:47 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":351,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"ELECTRIC PIE","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:47 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:47 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":228,"duration":351,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"ELECTRIC PIE","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:47 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:47 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:47 volumio volumio[1001]: info: ------------------------------ 33ms Apr 20 20:57:47 volumio volumio[1001]: info: ------------------------------ 37ms Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 10 milliseconds Apr 20 20:57:47 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:47 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:47 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":351,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"ELECTRIC PIE","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:47 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:47 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:47 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:47 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":351,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"ELECTRIC PIE","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:47 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:47 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:47 volumio volumio[1001]: info: ------------------------------ 40ms Apr 20 20:57:47 volumio volumio[1001]: info: ------------------------------ 39ms Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:47 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:47 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:47 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:47 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:47 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:47 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:47 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:47 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:57:47 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:57:47 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:57:55 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::ClearQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::stPlaybackTimer Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::serviceStop Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::serviceStop Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:57:55 volumio volumio[1001]: info: ControllerMpd::stop Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::clearPlayQueue Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::addQueueItems Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::addQueueItems Apr 20 20:57:55 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:57:55 volumio volumio[1001]: info: Adding Item to queue: yandex_music/album/13128362 Apr 20 20:57:55 volumio volumio[1001]: info: Exploding uri yandex_music/album/13128362 in service yandex_music Apr 20 20:57:55 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:55 volumio volumio[1001]: info: Apr 20 20:57:55 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:55 volumio volumio[1001]: info: sendMpdCommand stop took 17 milliseconds Apr 20 20:57:55 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:55 volumio volumio[1001]: info: sendMpdCommand status took 1 milliseconds Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:55 volumio volumio[1001]: info: Apr 20 20:57:55 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:55 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:55 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 20 20:57:55 volumio volumio[1001]: info: sendMpdCommand status took 23 milliseconds Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:55 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:55 volumio volumio[1001]: 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":"A-Ha","artist":"ELECTRIC PIE","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:55 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:55 volumio volumio[1001]: info: No code Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:55 volumio volumio[1001]: info: ------------------------------ 43ms Apr 20 20:57:55 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 20 20:57:55 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:55 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:55 volumio volumio[1001]: 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":"A-Ha","artist":"ELECTRIC PIE","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D1d444e68b69dbade25557d8d45c7d3ddea9cbe7e3762c0e90e715e30eccfe371%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812a708%2F0%2F58305%2F8b1487e5.83538494.6.56166482%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:55 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:55 volumio volumio[1001]: info: No code Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:55 volumio volumio[1001]: info: ------------------------------ 58ms Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:55 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:55 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:55 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:55 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:55 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:55 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:55 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:55 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:55 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:57:55 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:57:56 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:57:56 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:57:56 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:57:56 volumio volumio[1001]: info: CoreCommandRouter::volumioPlay Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::play index 0 Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:57:56 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:57:56 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:57:56 volumio volumio[1001]: info: sendMpdCommand stop took 3 milliseconds Apr 20 20:57:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:56 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:56 volumio volumio[1001]: info: sendMpdCommand clear took 0 milliseconds Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:56 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:56 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:56 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:56 volumio volumio[1001]: info: ------------------------------ 5ms Apr 20 20:57:56 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:57:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D98374ac58c618301ba579736e9a09dd73989dc43e2fcf5ab6b20279f7d6094d3%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68128648%2F67571%2F1738613%2Fd660e170.113566433.9.74908541%2F320.mp3&ext=.mp3" Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:56 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:56 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D98374ac58c618301ba579736e9a09dd73989dc43e2fcf5ab6b20279f7d6094d3%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68128648%2F67571%2F1738613%2Fd660e170.113566433.9.74908541%2F320.mp3&ext=.mp3" took 1 milliseconds Apr 20 20:57:56 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:57:56 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:56 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:56 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:56 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:56 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:57:56 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:57:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:56 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:56 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:57:56 volumio volumio[1001]: info: sendMpdCommand play took 2 milliseconds Apr 20 20:57:56 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:56 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:56 volumio volumio[1001]: info: Apr 20 20:57:56 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:56 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:56 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:56 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:57:56 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:57:56 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:57:56 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:57:56 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:57:56 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:57:57 volumio volumio[1001]: info: Apr 20 20:57:57 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand status took 24 milliseconds Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand status took 24 milliseconds Apr 20 20:57:57 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:57 volumio volumio[1001]: info: Apr 20 20:57:57 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:57 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:57:57 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:57 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":436,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Valdritz Ferraro","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D98374ac58c618301ba579736e9a09dd73989dc43e2fcf5ab6b20279f7d6094d3%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68128648%2F67571%2F1738613%2Fd660e170.113566433.9.74908541%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:57 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:57 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:57 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":505,"duration":436,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Valdritz Ferraro","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D98374ac58c618301ba579736e9a09dd73989dc43e2fcf5ab6b20279f7d6094d3%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68128648%2F67571%2F1738613%2Fd660e170.113566433.9.74908541%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:57 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:57 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:57 volumio volumio[1001]: info: ------------------------------ 34ms Apr 20 20:57:57 volumio volumio[1001]: info: ------------------------------ 36ms Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 12 milliseconds Apr 20 20:57:57 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:57 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:57:57 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:57 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":436,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Valdritz Ferraro","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D98374ac58c618301ba579736e9a09dd73989dc43e2fcf5ab6b20279f7d6094d3%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68128648%2F67571%2F1738613%2Fd660e170.113566433.9.74908541%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:57 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:57 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:57 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:57 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":436,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"A-Ha","artist":"Valdritz Ferraro","album":"A-Ha","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D98374ac58c618301ba579736e9a09dd73989dc43e2fcf5ab6b20279f7d6094d3%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68128648%2F67571%2F1738613%2Fd660e170.113566433.9.74908541%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:57:57 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:57 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:57 volumio volumio[1001]: info: ------------------------------ 39ms Apr 20 20:57:57 volumio volumio[1001]: info: ------------------------------ 39ms Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:57 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:57 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:57 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:57 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:57 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:57 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:57 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:57 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:57 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:57:57 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::volumioNext Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::next Apr 20 20:57:59 volumio volumio[1001]: info: ControllerMpd::next Apr 20 20:57:59 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand next Apr 20 20:57:59 volumio volumio[1001]: info: Apr 20 20:57:59 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:59 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:59 volumio volumio[1001]: info: Apr 20 20:57:59 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:59 volumio volumio[1001]: info: sendMpdCommand next took 5 milliseconds Apr 20 20:57:59 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:59 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:59 volumio volumio[1001]: info: Apr 20 20:57:59 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:57:59 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:57:59 volumio volumio[1001]: info: Apr 20 20:57:59 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:57:59 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:57:59 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:57:59 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:57:59 volumio volumio[1001]: info: ------------------------------ 5ms Apr 20 20:57:59 volumio volumio[1001]: info: sendMpdCommand status took 4 milliseconds Apr 20 20:57:59 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:57:59 volumio volumio[1001]: info: sendMpdCommand status took 1 milliseconds Apr 20 20:57:59 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:57:59 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:59 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:59 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:57:59 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::stPlaybackTimer Apr 20 20:57:59 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:59 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:57:59 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:57:59 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:59 volumio volumio[1001]: info: No code Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:57:59 volumio volumio[1001]: info: ------------------------------ 25ms Apr 20 20:57:59 volumio volumio[1001]: info: ------------------------------ 25ms Apr 20 20:57:59 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:57:59 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:57:59 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:57:59 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:57:59 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:58:01 volumio volumio[1001]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Apr 20 20:58:01 volumio go-librespot[1323]: time="2025-04-20T20:58:01+03:00" level=trace msg="sent dealer ping" Apr 20 20:58:01 volumio go-librespot[1323]: time="2025-04-20T20:58:01+03:00" level=trace msg="received dealer pong" Apr 20 20:58:02 volumio volumio[1001]: info: peppy_screensaver: Start PeppyMeter Apr 20 20:58:14 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:58:14 volumio volumio[1001]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:58:14 volumio volumio[1001]: info: CoreStateMachine::ClearQueue Apr 20 20:58:14 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:58:14 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:14 volumio volumio[1001]: info: CorePlayQueue::clearPlayQueue Apr 20 20:58:14 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:58:14 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:58:14 volumio volumio[1001]: info: CoreStateMachine::addQueueItems Apr 20 20:58:14 volumio volumio[1001]: info: CorePlayQueue::addQueueItems Apr 20 20:58:14 volumio volumio[1001]: info: Preload queue cleared Apr 20 20:58:14 volumio volumio[1001]: info: Adding Item to queue: yandex_music/artist/291 Apr 20 20:58:14 volumio volumio[1001]: info: Using cached record of: yandex_music/artist/291 Apr 20 20:58:14 volumio volumio[1001]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:58:15 volumio volumio[1001]: info: CorePlayQueue::saveQueue Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::updateTrackBlock Apr 20 20:58:15 volumio volumio[1001]: info: CorePlayQueue::getTrackBlock Apr 20 20:58:15 volumio volumio[1001]: info: CoreCommandRouter::volumioPlay Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::play index 0 Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::stop Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:58:15 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:58:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:58:15 volumio volumio[1001]: info: sendMpdCommand stop took 50 milliseconds Apr 20 20:58:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:58:15 volumio volumio[1001]: info: Apr 20 20:58:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:15 volumio volumio[1001]: info: sendMpdCommand clear took 8 milliseconds Apr 20 20:58:15 volumio volumio[1001]: info: Apr 20 20:58:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:15 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:15 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:15 volumio volumio[1001]: info: ------------------------------ 5ms Apr 20 20:58:15 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:58:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-11.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbf141cd60d4c1fc046a4e6da3e7ec94a583e2093d5b2924a58d65fbb056f0f8f%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812c8a3%2F29007%2F1749274%2Fc92d9097.93448867.12.38157643%2F320.mp3&ext=.mp3" Apr 20 20:58:15 volumio volumio[1001]: info: Apr 20 20:58:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:15 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-11.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbf141cd60d4c1fc046a4e6da3e7ec94a583e2093d5b2924a58d65fbb056f0f8f%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812c8a3%2F29007%2F1749274%2Fc92d9097.93448867.12.38157643%2F320.mp3&ext=.mp3" took 1 milliseconds Apr 20 20:58:15 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:15 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:15 volumio volumio[1001]: info: Apr 20 20:58:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:15 volumio volumio[1001]: info: Apr 20 20:58:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:15 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:15 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:58:15 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:58:15 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:58:15 volumio volumio[1001]: info: Apr 20 20:58:15 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:15 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:15 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:15 volumio volumio[1001]: info: sendMpdCommand play took 2 milliseconds Apr 20 20:58:15 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:58:16 volumio volumio[1001]: info: Apr 20 20:58:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:16 volumio volumio[1001]: info: Apr 20 20:58:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:58:16 volumio volumio[1001]: info: Apr 20 20:58:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand status took 18 milliseconds Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand status took 17 milliseconds Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:16 volumio volumio[1001]: info: Apr 20 20:58:16 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:58:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take On Me","artist":"a-ha","album":"Take On Me","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-11.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbf141cd60d4c1fc046a4e6da3e7ec94a583e2093d5b2924a58d65fbb056f0f8f%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812c8a3%2F29007%2F1749274%2Fc92d9097.93448867.12.38157643%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:58:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":426,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take On Me","artist":"a-ha","album":"Take On Me","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-11.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbf141cd60d4c1fc046a4e6da3e7ec94a583e2093d5b2924a58d65fbb056f0f8f%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812c8a3%2F29007%2F1749274%2Fc92d9097.93448867.12.38157643%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:16 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:16 volumio volumio[1001]: info: ------------------------------ 27ms Apr 20 20:58:16 volumio volumio[1001]: info: ------------------------------ 33ms Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 20 20:58:16 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 20 20:58:16 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:58:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take On Me","artist":"a-ha","album":"Take On Me","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-11.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbf141cd60d4c1fc046a4e6da3e7ec94a583e2093d5b2924a58d65fbb056f0f8f%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812c8a3%2F29007%2F1749274%2Fc92d9097.93448867.12.38157643%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:16 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:16 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:58:16 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":184,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Take On Me","artist":"a-ha","album":"Take On Me","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2Fstrm-m9-11.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dbf141cd60d4c1fc046a4e6da3e7ec94a583e2093d5b2924a58d65fbb056f0f8f%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812c8a3%2F29007%2F1749274%2Fc92d9097.93448867.12.38157643%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:16 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:16 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:16 volumio volumio[1001]: info: ------------------------------ 50ms Apr 20 20:58:16 volumio volumio[1001]: info: ------------------------------ 49ms Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:16 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:16 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:16 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:58:16 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:58:16 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::volumioNext Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::next Apr 20 20:58:19 volumio volumio[1001]: info: ControllerMpd::next Apr 20 20:58:19 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand next Apr 20 20:58:19 volumio volumio[1001]: info: sendMpdCommand next took 3 milliseconds Apr 20 20:58:19 volumio volumio[1001]: info: Apr 20 20:58:19 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:19 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:19 volumio volumio[1001]: info: Apr 20 20:58:19 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:19 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:19 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:19 volumio volumio[1001]: info: Apr 20 20:58:19 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:19 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:19 volumio volumio[1001]: info: Apr 20 20:58:19 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:19 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:19 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:19 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:19 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:19 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:58:19 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:19 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:19 volumio volumio[1001]: info: sendMpdCommand status took 1 milliseconds Apr 20 20:58:19 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:19 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:19 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getTrack 0 Apr 20 20:58:19 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:58:19 volumio volumio[1001]: verbose: CURRENT POSITION 0 Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:19 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:19 volumio volumio[1001]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:19 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:58:19 volumio volumio[1001]: info: ------------------------------ 15ms Apr 20 20:58:19 volumio volumio[1001]: info: ------------------------------ 14ms Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:19 volumio volumio[1001]: info: sendMpdCommand stop took 10 milliseconds Apr 20 20:58:19 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:58:19 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:19 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:19 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:19 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:19 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:19 volumio volumio[1001]: info: Apr 20 20:58:19 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:19 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:19 volumio volumio[1001]: info: sendMpdCommand clear took 35 milliseconds Apr 20 20:58:19 volumio volumio[1001]: info: Apr 20 20:58:19 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:19 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:19 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:19 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:19 volumio volumio[1001]: info: ------------------------------ 46ms Apr 20 20:58:19 volumio volumio[1001]: info: ------------------------------ 34ms Apr 20 20:58:19 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D180b783e90b9e24886d1595da267f4fde7901ecaa7aa028b94e39a24c71a3ed7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68129702%2F47499%2F1442501%2F589c3a6e.55839968.11.36945745%2F320.mp3&ext=.mp3" Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:20 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D180b783e90b9e24886d1595da267f4fde7901ecaa7aa028b94e39a24c71a3ed7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68129702%2F47499%2F1442501%2F589c3a6e.55839968.11.36945745%2F320.mp3&ext=.mp3" took 2 milliseconds Apr 20 20:58:20 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:20 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:20 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:20 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:20 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand play took 1 milliseconds Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:20 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:58:20 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:58:20 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand status took 37 milliseconds Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand status took 37 milliseconds Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:20 volumio volumio[1001]: info: Apr 20 20:58:20 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand status took 13 milliseconds Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 13 milliseconds Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 11 milliseconds Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand status took 8 milliseconds Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:20 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"This Is Our Home","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D180b783e90b9e24886d1595da267f4fde7901ecaa7aa028b94e39a24c71a3ed7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68129702%2F47499%2F1442501%2F589c3a6e.55839968.11.36945745%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:20 volumio volumio[1001]: verbose: CURRENT POSITION 1 Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:20 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":505,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"This Is Our Home","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D180b783e90b9e24886d1595da267f4fde7901ecaa7aa028b94e39a24c71a3ed7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68129702%2F47499%2F1442501%2F589c3a6e.55839968.11.36945745%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:20 volumio volumio[1001]: verbose: CURRENT POSITION 1 Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:20 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 59ms Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 63ms Apr 20 20:58:20 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 20 20:58:20 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:20 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1008,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"This Is Our Home","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D180b783e90b9e24886d1595da267f4fde7901ecaa7aa028b94e39a24c71a3ed7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68129702%2F47499%2F1442501%2F589c3a6e.55839968.11.36945745%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:20 volumio volumio[1001]: verbose: CURRENT POSITION 1 Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:20 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:20 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:20 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1008,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"This Is Our Home","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D180b783e90b9e24886d1595da267f4fde7901ecaa7aa028b94e39a24c71a3ed7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68129702%2F47499%2F1442501%2F589c3a6e.55839968.11.36945745%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:20 volumio volumio[1001]: verbose: CURRENT POSITION 1 Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:20 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 52ms Apr 20 20:58:20 volumio volumio[1001]: info: ------------------------------ 48ms Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:20 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:20 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:20 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:20 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:20 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:20 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:20 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:20 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:20 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:58:20 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::volumioNext Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::next Apr 20 20:58:24 volumio volumio[1001]: info: ControllerMpd::next Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand next Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:24 volumio volumio[1001]: info: sendMpdCommand next took 7 milliseconds Apr 20 20:58:24 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:24 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:24 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:24 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 6ms Apr 20 20:58:24 volumio volumio[1001]: info: sendMpdCommand status took 5 milliseconds Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:24 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getTrack 1 Apr 20 20:58:24 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:58:24 volumio volumio[1001]: verbose: CURRENT POSITION 1 Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 16ms Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:24 volumio volumio[1001]: info: sendMpdCommand status took 19 milliseconds Apr 20 20:58:24 volumio volumio[1001]: info: sendMpdCommand stop took 7 milliseconds Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:58:24 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:24 volumio volumio[1001]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 26ms Apr 20 20:58:24 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:24 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:24 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:24 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:24 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: info: sendMpdCommand clear took 34 milliseconds Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 35ms Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 27ms Apr 20 20:58:24 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D615b3fbb319f0e3be61225412e799a9095809dd57ac0556d47ae775d5c95bac7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812929b%2F49503%2F1767066%2Fd22e4846.55839969.11.37284617%2F320.mp3&ext=.mp3" Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D615b3fbb319f0e3be61225412e799a9095809dd57ac0556d47ae775d5c95bac7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812929b%2F49503%2F1767066%2Fd22e4846.55839969.11.37284617%2F320.mp3&ext=.mp3" took 1 milliseconds Apr 20 20:58:24 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:24 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 1ms Apr 20 20:58:24 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:58:24 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:58:24 volumio volumio[1001]: info: Apr 20 20:58:24 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:24 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:24 volumio volumio[1001]: info: sendMpdCommand play took 1 milliseconds Apr 20 20:58:24 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:25 volumio volumio[1001]: info: Apr 20 20:58:25 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:25 volumio volumio[1001]: info: Apr 20 20:58:25 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:25 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:58:25 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:58:25 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:58:25 volumio volumio[1001]: info: Apr 20 20:58:25 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand status took 34 milliseconds Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand status took 33 milliseconds Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:25 volumio volumio[1001]: info: Apr 20 20:58:25 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:25 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":318,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Lifelines","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D615b3fbb319f0e3be61225412e799a9095809dd57ac0556d47ae775d5c95bac7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812929b%2F49503%2F1767066%2Fd22e4846.55839969.11.37284617%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:25 volumio volumio[1001]: verbose: CURRENT POSITION 2 Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:25 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":318,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Lifelines","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D615b3fbb319f0e3be61225412e799a9095809dd57ac0556d47ae775d5c95bac7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812929b%2F49503%2F1767066%2Fd22e4846.55839969.11.37284617%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:25 volumio volumio[1001]: verbose: CURRENT POSITION 2 Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:25 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:25 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1008,"duration":318,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Lifelines","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D615b3fbb319f0e3be61225412e799a9095809dd57ac0556d47ae775d5c95bac7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812929b%2F49503%2F1767066%2Fd22e4846.55839969.11.37284617%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:25 volumio volumio[1001]: verbose: CURRENT POSITION 2 Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:25 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:25 volumio volumio[1001]: info: ------------------------------ 56ms Apr 20 20:58:25 volumio volumio[1001]: info: ------------------------------ 58ms Apr 20 20:58:25 volumio volumio[1001]: info: ------------------------------ 27ms Apr 20 20:58:25 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 20 20:58:25 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:25 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:25 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1008,"duration":318,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Lifelines","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D615b3fbb319f0e3be61225412e799a9095809dd57ac0556d47ae775d5c95bac7%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6812929b%2F49503%2F1767066%2Fd22e4846.55839969.11.37284617%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:25 volumio volumio[1001]: verbose: CURRENT POSITION 2 Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:25 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:25 volumio volumio[1001]: info: ------------------------------ 36ms Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:25 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:25 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:25 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:25 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:25 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:25 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:25 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:25 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:25 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:58:25 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::volumioNext Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::next Apr 20 20:58:26 volumio volumio[1001]: info: ControllerMpd::next Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand next Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:26 volumio volumio[1001]: info: sendMpdCommand next took 4 milliseconds Apr 20 20:58:26 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:26 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:26 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:26 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 5ms Apr 20 20:58:26 volumio volumio[1001]: info: sendMpdCommand status took 4 milliseconds Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:58:26 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:26 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getTrack 2 Apr 20 20:58:26 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:58:26 volumio volumio[1001]: verbose: CURRENT POSITION 2 Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:26 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:26 volumio volumio[1001]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 18ms Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 17ms Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:26 volumio volumio[1001]: info: sendMpdCommand stop took 10 milliseconds Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:58:26 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:26 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:26 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:26 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:26 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: info: sendMpdCommand clear took 33 milliseconds Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:26 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 43ms Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 34ms Apr 20 20:58:26 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D27c6ba6505334bbb99fcbdcd0732a5844216c62bdcfc314b55ecd0708de6b56c%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127ba7%2F47467%2F1770423%2F06cb21f3.55839970.10.37284618%2F320.mp3&ext=.mp3" Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D27c6ba6505334bbb99fcbdcd0732a5844216c62bdcfc314b55ecd0708de6b56c%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127ba7%2F47467%2F1770423%2F06cb21f3.55839970.10.37284618%2F320.mp3&ext=.mp3" took 2 milliseconds Apr 20 20:58:26 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:26 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:26 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 4ms Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:26 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:58:26 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:58:26 volumio volumio[1001]: info: Apr 20 20:58:26 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:26 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 4ms Apr 20 20:58:26 volumio volumio[1001]: info: sendMpdCommand play took 3 milliseconds Apr 20 20:58:26 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:27 volumio volumio[1001]: info: Apr 20 20:58:27 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:27 volumio volumio[1001]: info: Apr 20 20:58:27 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:27 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:58:27 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:58:27 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:58:27 volumio volumio[1001]: info: Apr 20 20:58:27 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand status took 19 milliseconds Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand status took 19 milliseconds Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:27 volumio volumio[1001]: info: Apr 20 20:58:27 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand status took 8 milliseconds Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 8 milliseconds Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 9 milliseconds Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:27 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I've Been Losing You","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D27c6ba6505334bbb99fcbdcd0732a5844216c62bdcfc314b55ecd0708de6b56c%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127ba7%2F47467%2F1770423%2F06cb21f3.55839970.10.37284618%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:27 volumio volumio[1001]: verbose: CURRENT POSITION 3 Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:27 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":285,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I've Been Losing You","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D27c6ba6505334bbb99fcbdcd0732a5844216c62bdcfc314b55ecd0708de6b56c%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127ba7%2F47467%2F1770423%2F06cb21f3.55839970.10.37284618%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:27 volumio volumio[1001]: verbose: CURRENT POSITION 3 Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:27 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:27 volumio volumio[1001]: info: ------------------------------ 37ms Apr 20 20:58:27 volumio volumio[1001]: info: ------------------------------ 40ms Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand status took 15 milliseconds Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 14 milliseconds Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:27 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I've Been Losing You","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D27c6ba6505334bbb99fcbdcd0732a5844216c62bdcfc314b55ecd0708de6b56c%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127ba7%2F47467%2F1770423%2F06cb21f3.55839970.10.37284618%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:27 volumio volumio[1001]: verbose: CURRENT POSITION 3 Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:27 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:27 volumio volumio[1001]: info: ------------------------------ 37ms Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:27 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 82 milliseconds Apr 20 20:58:27 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:27 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:27 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1522,"duration":305,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"I've Been Losing You","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D27c6ba6505334bbb99fcbdcd0732a5844216c62bdcfc314b55ecd0708de6b56c%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127ba7%2F47467%2F1770423%2F06cb21f3.55839970.10.37284618%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:27 volumio volumio[1001]: verbose: CURRENT POSITION 3 Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:27 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:27 volumio volumio[1001]: info: ------------------------------ 109ms Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:27 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:27 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:27 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:27 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:58:27 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::volumioNext Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::next Apr 20 20:58:29 volumio volumio[1001]: info: ControllerMpd::next Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand next Apr 20 20:58:29 volumio volumio[1001]: info: sendMpdCommand next took 5 milliseconds Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:29 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:29 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:29 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:29 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 4ms Apr 20 20:58:29 volumio volumio[1001]: info: sendMpdCommand status took 3 milliseconds Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:29 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:29 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getTrack 3 Apr 20 20:58:29 volumio volumio[1001]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:58:29 volumio volumio[1001]: verbose: CURRENT POSITION 3 Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::syncState stateService stop Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::play index undefined Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:29 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:29 volumio volumio[1001]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 22ms Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 22ms Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:29 volumio volumio[1001]: info: sendMpdCommand stop took 9 milliseconds Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:58:29 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:29 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:29 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: info: sendMpdCommand clear took 30 milliseconds Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:29 volumio volumio[1001]: error: updateQueue error: null Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 37ms Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 27ms Apr 20 20:58:29 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 3600 seconds. Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95332bc0f988ef2cbee494f72494b2e0848cf6490fbd8db82ddbe7b1db3d8163%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127f97%2F44215%2F1767549%2Fa6eb6029.55839971.10.37284619%2F320.mp3&ext=.mp3" Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95332bc0f988ef2cbee494f72494b2e0848cf6490fbd8db82ddbe7b1db3d8163%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127f97%2F44215%2F1767549%2Fa6eb6029.55839971.10.37284619%2F320.mp3&ext=.mp3" took 2 milliseconds Apr 20 20:58:29 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:29 volumio volumio[1001]: verbose: MPD COMMAND [object Object] Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 3ms Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:29 volumio volumio[1001]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:58:29 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:58:29 volumio volumio[1001]: info: Apr 20 20:58:29 volumio volumio[1001]: ---------------------------- MPD announces system playlist update Apr 20 20:58:29 volumio volumio[1001]: info: Ignoring MPD Status Update Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:29 volumio volumio[1001]: info: sendMpdCommand play took 2 milliseconds Apr 20 20:58:29 volumio volumio[1001]: info: ------------------------------ 2ms Apr 20 20:58:30 volumio volumio[1001]: info: Apr 20 20:58:30 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:30 volumio volumio[1001]: info: Apr 20 20:58:30 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:30 volumio volumio[1001]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Apr 20 20:58:30 volumio volumio[1001]: info: FusionDsp - ---- read samplerate from file: 44100 Apr 20 20:58:30 volumio volumio[1001]: info: FusionDsp - If filter freq >samplerate/2 then disable it Apr 20 20:58:30 volumio volumio[1001]: info: Apr 20 20:58:30 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:30 volumio volumio[1001]: info: sendMpdCommand status took 23 milliseconds Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:30 volumio volumio[1001]: info: Apr 20 20:58:30 volumio volumio[1001]: ---------------------------- MPD announces state update: player Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::getState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:58:30 volumio volumio[1001]: info: sendMpdCommand status took 6 milliseconds Apr 20 20:58:30 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 20 20:58:30 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 20 20:58:30 volumio volumio[1001]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseState Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:30 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":284,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Analogue (All I Want)","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95332bc0f988ef2cbee494f72494b2e0848cf6490fbd8db82ddbe7b1db3d8163%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127f97%2F44215%2F1767549%2Fa6eb6029.55839971.10.37284619%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:30 volumio volumio[1001]: verbose: CURRENT POSITION 4 Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:30 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":284,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Analogue (All I Want)","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95332bc0f988ef2cbee494f72494b2e0848cf6490fbd8db82ddbe7b1db3d8163%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127f97%2F44215%2F1767549%2Fa6eb6029.55839971.10.37284619%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:30 volumio volumio[1001]: verbose: CURRENT POSITION 4 Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:30 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:30 volumio volumio[1001]: info: ------------------------------ 37ms Apr 20 20:58:30 volumio volumio[1001]: info: ------------------------------ 46ms Apr 20 20:58:30 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 20 20:58:30 volumio volumio[1001]: info: sendMpdCommand playlistinfo took 17 milliseconds Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:30 volumio volumio[1001]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:30 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1260,"duration":284,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Analogue (All I Want)","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95332bc0f988ef2cbee494f72494b2e0848cf6490fbd8db82ddbe7b1db3d8163%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127f97%2F44215%2F1767549%2Fa6eb6029.55839971.10.37284619%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:30 volumio volumio[1001]: verbose: CURRENT POSITION 4 Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:30 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:30 volumio volumio[1001]: info: ControllerMpd::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::servicePushState Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getTrack 4 Apr 20 20:58:30 volumio volumio[1001]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1512,"duration":284,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Analogue (All I Want)","artist":"a-ha","album":"MTV Unplugged - Summer Solstice","uri":"http://localhost:6601/?codec=mp3&url=https%3A%2F%2F136.cold-rtc.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D95332bc0f988ef2cbee494f72494b2e0848cf6490fbd8db82ddbe7b1db3d8163%2Clid%3D136%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D68127f97%2F44215%2F1767549%2Fa6eb6029.55839971.10.37284619%2F320.mp3&ext=.mp3","trackType":"mp3"} Apr 20 20:58:30 volumio volumio[1001]: verbose: CURRENT POSITION 4 Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState stateService play Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:58:30 volumio volumio[1001]: info: Received an update from plugin. extracting info from payload Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::pushState Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioPushState Apr 20 20:58:30 volumio volumio[1001]: info: ------------------------------ 55ms Apr 20 20:58:30 volumio volumio[1001]: info: ------------------------------ 49ms Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioGetQueue Apr 20 20:58:30 volumio volumio[1001]: info: CoreStateMachine::getQueue Apr 20 20:58:30 volumio volumio[1001]: info: CorePlayQueue::getQueue Apr 20 20:58:30 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:30 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:30 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:30 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:30 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:30 volumio volumio[1001]: SPOTIFY: RECEIVED VOLUMIO VOLUME 70 Apr 20 20:58:30 volumio volumio[1001]: info: FusionDsp - {"Reload":{"result":"Ok"}} Apr 20 20:58:30 volumio volumio[1001]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Apr 20 20:58:30 volumio volumio[1001]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 20 20:58:30 volumio volumio[1001]: info: CoreCommandRouter::volumioGetState Apr 20 20:58:31 volumio go-librespot[1323]: time="2025-04-20T20:58:31+03:00" level=trace msg="sent dealer ping" Apr 20 20:58:31 volumio go-librespot[1323]: time="2025-04-20T20:58:31+03:00" level=trace msg="received dealer pong" Apr 20 20:58:41 volumio volumio[1001]: Searching plugin music_service/yandex_music Apr 20 20:58:41 volumio volumio[1001]: info: CoreCommandRouter::executeOnPlugin: yandex_music , search Apr 20 20:58:46 volumio volumio[1001]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 20:58:46 volumio volumio[1001]: Error: read ECONNRESET Apr 20 20:58:46 volumio volumio[1001]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:209:20) { Apr 20 20:58:46 volumio volumio[1001]: errno: -104, Apr 20 20:58:46 volumio volumio[1001]: code: 'ECONNRESET', Apr 20 20:58:46 volumio volumio[1001]: syscall: 'read' Apr 20 20:58:46 volumio volumio[1001]: } Apr 20 20:58:46 volumio volumio[1001]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 20:58:46 volumio sudo[24168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-20 20:57 Apr 20 20:58:46 volumio sudo[24168]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"