Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::volumioNext Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::next Oct 14 10:38:35 volumio volumio[1075]: info: ControllerMpd::next Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand next Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand next took 2 milliseconds Oct 14 10:38:35 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:35 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:35 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:35 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:35 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:35 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand status took 3 milliseconds Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand status took 2 milliseconds Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:35 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 15 Oct 14 10:38:35 volumio volumio[1075]: 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} Oct 14 10:38:35 volumio volumio[1075]: verbose: CURRENT POSITION 15 Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::syncState stateService stop Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::play index undefined Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:35 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand stop Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 14ms Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 13ms Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand status took 17 milliseconds Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand stop took 5 milliseconds Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand clear Oct 14 10:38:35 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:35 volumio volumio[1075]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 20ms Oct 14 10:38:35 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:35 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand clear took 5 milliseconds Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:35 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:35 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 7ms Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3" Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3" took 1 milliseconds Oct 14 10:38:35 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:35 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:35 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:35 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 14 10:38:35 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand play Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: Oct 14 10:38:35 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:35 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:35 volumio volumio[1075]: info: sendMpdCommand play took 2 milliseconds Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:35 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioAddQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::addQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::addQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: Preload queue cleared Oct 14 10:38:36 volumio volumio[1075]: info: Adding Item to queue: yandex_music/track/2192830:217019@user:onyourwave Oct 14 10:38:36 volumio volumio[1075]: info: Exploding uri yandex_music/track/2192830:217019@user:onyourwave in service yandex_music Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioAddQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::addQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::addQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: Preload queue cleared Oct 14 10:38:36 volumio volumio[1075]: info: Adding Item to queue: yandex_music/track/2774867:298151@user:onyourwave Oct 14 10:38:36 volumio volumio[1075]: info: Exploding uri yandex_music/track/2774867:298151@user:onyourwave in service yandex_music Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioAddQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::addQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::addQueueItems Oct 14 10:38:36 volumio volumio[1075]: info: Preload queue cleared Oct 14 10:38:36 volumio volumio[1075]: info: Adding Item to queue: yandex_music/track/105014042:22675744@user:onyourwave Oct 14 10:38:36 volumio volumio[1075]: info: Exploding uri yandex_music/track/105014042:22675744@user:onyourwave in service yandex_music Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::saveQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::saveQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::saveQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 16 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 17 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 17 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:36 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":263,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't Speak","artist":"No Doubt","album":"The Singles Collection","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:36 volumio volumio[1075]: verbose: CURRENT POSITION 16 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus stop Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 19ms Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 3 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:36 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":263,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't Speak","artist":"No Doubt","album":"The Singles Collection","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:36 volumio volumio[1075]: verbose: CURRENT POSITION 16 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:36 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:36 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":263,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't Speak","artist":"No Doubt","album":"The Singles Collection","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:36 volumio volumio[1075]: verbose: CURRENT POSITION 16 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:36 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:36 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":263,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't Speak","artist":"No Doubt","album":"The Singles Collection","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:36 volumio volumio[1075]: verbose: CURRENT POSITION 16 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:36 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 28ms Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 28ms Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 12ms Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 9 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:36 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":263,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't Speak","artist":"No Doubt","album":"The Singles Collection","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:36 volumio volumio[1075]: verbose: CURRENT POSITION 16 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:36 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 15ms Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 15 milliseconds Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:36 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":263,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Don't Speak","artist":"No Doubt","album":"The Singles Collection","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-std-42.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D3addcabf16a106d7385cfe94374b42fccc1d620d92b76704e6f079ad20bad295%2Clid%3D46%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc921f%2F41031%2F1780679%2F302d1dde.88519676.19.52100%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:36 volumio volumio[1075]: verbose: CURRENT POSITION 16 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:36 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 28ms Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioNext Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::next Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::next Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand next Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:36 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand next took 1 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:36 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:36 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:36 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:36 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:36 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 0 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 0ms Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand status took 0 milliseconds Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 16 Oct 14 10:38:36 volumio volumio[1075]: 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} Oct 14 10:38:36 volumio volumio[1075]: verbose: CURRENT POSITION 16 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState stateService stop Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::play index undefined Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Oct 14 10:38:36 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand stop Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 8ms Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 8ms Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 7ms Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand stop took 4 milliseconds Oct 14 10:38:36 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand clear Oct 14 10:38:36 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:36 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:36 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:36 volumio volumio[1075]: info: sendMpdCommand clear took 4 milliseconds Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:36 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:36 volumio volumio[1075]: info: Oct 14 10:38:36 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:36 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:36 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:36 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:36 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 6ms Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 4ms Oct 14 10:38:36 volumio volumio[1075]: info: ------------------------------ 4ms Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3" Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:37 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand addid "http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3" took 2 milliseconds Oct 14 10:38:37 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:37 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:37 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:37 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:37 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:37 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand play Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:37 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:37 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand play took 0 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 0ms Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 0ms Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand status took 14 milliseconds Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand status took 15 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand status took 14 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:37 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":197,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ola Del Sol","artist":"Andrea Ribeca","album":"Ola Del Sol","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:37 volumio volumio[1075]: verbose: CURRENT POSITION 17 Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus stop Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 17ms Oct 14 10:38:37 volumio volumio[1075]: info: Oct 14 10:38:37 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand status took 2 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand status took 2 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:37 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":197,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ola Del Sol","artist":"Andrea Ribeca","album":"Ola Del Sol","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:37 volumio volumio[1075]: verbose: CURRENT POSITION 17 Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:37 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:37 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":729,"duration":197,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ola Del Sol","artist":"Andrea Ribeca","album":"Ola Del Sol","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:37 volumio volumio[1075]: verbose: CURRENT POSITION 17 Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:37 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 22ms Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 23ms Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand status took 7 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:37 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":197,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ola Del Sol","artist":"Andrea Ribeca","album":"Ola Del Sol","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:37 volumio volumio[1075]: verbose: CURRENT POSITION 17 Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:37 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:37 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":197,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ola Del Sol","artist":"Andrea Ribeca","album":"Ola Del Sol","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:37 volumio volumio[1075]: verbose: CURRENT POSITION 17 Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:37 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 14ms Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 15ms Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 22 milliseconds Oct 14 10:38:37 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:37 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:37 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":197,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ola Del Sol","artist":"Andrea Ribeca","album":"Ola Del Sol","uri":"http://localhost:6601/?codec=mp3&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-24.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Def78537e8c92604f241ab5cb50d4eefe50de57cf6818f1f10a5a1e99e29d7d2a%2Clid%3D47%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D6adc88d2%2F0%2F1525961%2F521608c0.77984402.1.52633205%2F2.mp3&ext=.mp3","trackType":"mp3"} Oct 14 10:38:37 volumio volumio[1075]: verbose: CURRENT POSITION 17 Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:37 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:37 volumio volumio[1075]: info: ------------------------------ 33ms Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioAddQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::addQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::addQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: Preload queue cleared Oct 14 10:38:37 volumio volumio[1075]: info: Adding Item to queue: yandex_music/track/76275:63325@user:onyourwave Oct 14 10:38:37 volumio volumio[1075]: info: Exploding uri yandex_music/track/76275:63325@user:onyourwave in service yandex_music Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioAddQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::addQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::addQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: Preload queue cleared Oct 14 10:38:37 volumio volumio[1075]: info: Adding Item to queue: yandex_music/track/21168:2754@user:onyourwave Oct 14 10:38:37 volumio volumio[1075]: info: Exploding uri yandex_music/track/21168:2754@user:onyourwave in service yandex_music Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioAddQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::addQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::addQueueItems Oct 14 10:38:37 volumio volumio[1075]: info: Preload queue cleared Oct 14 10:38:37 volumio volumio[1075]: info: Adding Item to queue: yandex_music/track/2192801:217019@user:onyourwave Oct 14 10:38:37 volumio volumio[1075]: info: Exploding uri yandex_music/track/2192801:217019@user:onyourwave in service yandex_music Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::saveQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::saveQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::saveQueue Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:37 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:37 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:41 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 14 10:38:41 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 14 10:38:45 volumio volumio[1075]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 14 10:38:47 volumio volumio[1075]: info: CALLMETHOD: music_service yandex_music configPlaybackSave [object Object] Oct 14 10:38:47 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: yandex_music , configPlaybackSave Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::volumioPlay Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::play index 21 Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::stop Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::stPlaybackTimer Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::serviceStop Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 17 Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::serviceStop Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 14 10:38:54 volumio volumio[1075]: info: ControllerMpd::stop Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand stop Oct 14 10:38:54 volumio volumio[1075]: info: Oct 14 10:38:54 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:54 volumio volumio[1075]: info: sendMpdCommand stop took 2 milliseconds Oct 14 10:38:54 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::play index undefined Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand stop Oct 14 10:38:54 volumio volumio[1075]: info: sendMpdCommand status took 5 milliseconds Oct 14 10:38:54 volumio volumio[1075]: info: sendMpdCommand stop took 4 milliseconds Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand clear Oct 14 10:38:54 volumio volumio[1075]: info: Oct 14 10:38:54 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:54 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:54 volumio volumio[1075]: info: Oct 14 10:38:54 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:54 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:54 volumio volumio[1075]: info: Oct 14 10:38:54 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:54 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:54 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:38:54 volumio volumio[1075]: info: sendMpdCommand clear took 1 milliseconds Oct 14 10:38:54 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:38:54 volumio volumio[1075]: info: sendMpdCommand status took 0 milliseconds Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:54 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:54 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Oct 14 10:38:54 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Oct 14 10:38:54 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:54 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:54 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:54 volumio volumio[1075]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current yandex_music Received mpd Oct 14 10:38:54 volumio volumio[1075]: info: ------------------------------ 9ms Oct 14 10:38:54 volumio volumio[1075]: info: ------------------------------ 4ms Oct 14 10:38:54 volumio volumio[1075]: info: ------------------------------ 3ms Oct 14 10:38:54 volumio volumio[1075]: info: Oct 14 10:38:54 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:54 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:54 volumio volumio[1075]: info: Oct 14 10:38:54 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:54 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:54 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:54 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:54 volumio volumio[1075]: error: updateQueue error: null Oct 14 10:38:54 volumio volumio[1075]: info: ------------------------------ 7ms Oct 14 10:38:54 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:54 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:55 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand addid "https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA" Oct 14 10:38:55 volumio volumio[1075]: info: Oct 14 10:38:55 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:55 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:55 volumio volumio[1075]: info: sendMpdCommand addid "https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA" took 1 milliseconds Oct 14 10:38:55 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:55 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:55 volumio volumio[1075]: verbose: MPD COMMAND [object Object] Oct 14 10:38:55 volumio volumio[1075]: info: Oct 14 10:38:55 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:55 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:55 volumio volumio[1075]: info: Oct 14 10:38:55 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:55 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:55 volumio volumio[1075]: info: Oct 14 10:38:55 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:55 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:55 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:55 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:55 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:55 volumio volumio[1075]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 14 10:38:55 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand play Oct 14 10:38:55 volumio volumio[1075]: info: Oct 14 10:38:55 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:55 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:55 volumio volumio[1075]: info: Oct 14 10:38:55 volumio volumio[1075]: ---------------------------- MPD announces system playlist update Oct 14 10:38:55 volumio volumio[1075]: info: Ignoring MPD Status Update Oct 14 10:38:55 volumio volumio[1075]: info: ------------------------------ 2ms Oct 14 10:38:55 volumio volumio[1075]: info: sendMpdCommand play took 1 milliseconds Oct 14 10:38:55 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:55 volumio volumio[1075]: info: ------------------------------ 1ms Oct 14 10:38:55 volumio volumio[1075]: info: CoreCommandRouter::volumioAddQueueItems Oct 14 10:38:55 volumio volumio[1075]: info: CoreStateMachine::addQueueItems Oct 14 10:38:55 volumio volumio[1075]: info: CorePlayQueue::addQueueItems Oct 14 10:38:55 volumio volumio[1075]: info: Preload queue cleared Oct 14 10:38:55 volumio volumio[1075]: info: Adding Item to queue: yandex_music/track/44092998:5901220@user:onyourwave Oct 14 10:38:55 volumio volumio[1075]: info: Exploding uri yandex_music/track/44092998:5901220@user:onyourwave in service yandex_music Oct 14 10:38:55 volumio volumio[1075]: info: CoreCommandRouter::volumioPushQueue Oct 14 10:38:55 volumio volumio[1075]: info: CorePlayQueue::saveQueue Oct 14 10:38:55 volumio volumio[1075]: info: CoreStateMachine::updateTrackBlock Oct 14 10:38:55 volumio volumio[1075]: info: CorePlayQueue::getTrackBlock Oct 14 10:38:56 volumio systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 14 10:38:58 volumio volumio[1075]: info: Oct 14 10:38:58 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:58 volumio volumio[1075]: info: Oct 14 10:38:58 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:58 volumio volumio[1075]: info: Oct 14 10:38:58 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:58 volumio volumio[1075]: info: Oct 14 10:38:58 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand status took 14 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:58 volumio volumio[1075]: info: Oct 14 10:38:58 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand status took 15 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand status took 14 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand status took 2 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:58 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:38:58 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus stop Oct 14 10:38:58 volumio volumio[1075]: info: ------------------------------ 18ms Oct 14 10:38:58 volumio volumio[1075]: info: Oct 14 10:38:58 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand status took 0 milliseconds Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:58 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:38:58 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:58 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:58 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:38:58 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:58 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:58 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:38:58 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:58 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:58 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:38:58 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:58 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: ------------------------------ 27ms Oct 14 10:38:58 volumio volumio[1075]: info: ------------------------------ 27ms Oct 14 10:38:58 volumio volumio[1075]: info: ------------------------------ 13ms Oct 14 10:38:58 volumio volumio[1075]: info: ------------------------------ 12ms Oct 14 10:38:58 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 10 milliseconds Oct 14 10:38:58 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:38:58 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:38:58 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":981,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:38:58 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:38:58 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:38:58 volumio volumio[1075]: info: ------------------------------ 14ms Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:38:58 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:38:58 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:38:58 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 14 10:38:58 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 14 10:39:00 volumio volumio[1075]: info: VolumeController::SetAlsaVolume18 Oct 14 10:39:00 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:00 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:00 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:00 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:00 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:00 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:00 volumio volumio[1075]: info: VolumeController::SetAlsaVolume25 Oct 14 10:39:00 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:00 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:00 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:00 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:00 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:00 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:01 volumio volumio[1075]: info: VolumeController::SetAlsaVolume26 Oct 14 10:39:01 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:01 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:01 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:01 volumio volumio[1075]: info: VolumeController::SetAlsaVolume32 Oct 14 10:39:01 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:01 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:01 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:01 volumio volumio[1075]: info: VolumeController::SetAlsaVolume33 Oct 14 10:39:01 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:01 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:01 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:01 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: VolumeController::SetAlsaVolume34 Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: VolumeController::SetAlsaVolume35 Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: VolumeController::SetAlsaVolume36 Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: VolumeController::SetAlsaVolume37 Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: VolumeController::SetAlsaVolume38 Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: VolumeController::SetAlsaVolume39 Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:02 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:02 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:02 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:03 volumio volumio[1075]: info: VolumeController::SetAlsaVolume40 Oct 14 10:39:03 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:03 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:03 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:03 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:03 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:03 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:03 volumio volumio[1075]: info: VolumeController::SetAlsaVolume41 Oct 14 10:39:03 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:03 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:03 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:03 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:03 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:03 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:04 volumio volumio[1075]: info: VolumeController::SetAlsaVolume42 Oct 14 10:39:04 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:04 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:04 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:04 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:04 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:04 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioSeek Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::seek Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: info: TRACKBLOCK {"id":"6689073:11644773@user:onyourwave","service":"yandex_music","type":"song","name":"Narayan","title":"Narayan","album":"The Fat of the Land - Expanded Edition","artist":"The Prodigy","duration":546,"albumart":"https://avatars.yandex.net/get-music-content/2433821/1272814a.a.11644773-1/200x200","uri":"yandex_music/track/6689073:11644773@user:onyourwave","samplerate":"","bitdepth":"","trackType":"","codec":"mp3","bitrate":192} Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::seek Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: error: null Oct 14 10:39:06 volumio volumio[1075]: info: Oct 14 10:39:06 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:06 volumio volumio[1075]: info: Oct 14 10:39:06 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:06 volumio volumio[1075]: info: Oct 14 10:39:06 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand status took 3 milliseconds Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand status took 2 milliseconds Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand status took 2 milliseconds Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7000,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:06 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:06 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7000,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:06 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:06 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":7000,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:06 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:06 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: ------------------------------ 11ms Oct 14 10:39:06 volumio volumio[1075]: info: ------------------------------ 10ms Oct 14 10:39:06 volumio volumio[1075]: info: ------------------------------ 10ms Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioSeek Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::seek Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: info: TRACKBLOCK {"id":"6689073:11644773@user:onyourwave","service":"yandex_music","type":"song","name":"Narayan","title":"Narayan","album":"The Fat of the Land - Expanded Edition","artist":"The Prodigy","duration":546,"albumart":"https://avatars.yandex.net/get-music-content/2433821/1272814a.a.11644773-1/200x200","uri":"yandex_music/track/6689073:11644773@user:onyourwave","samplerate":"","bitdepth":"","trackType":"","codec":"mp3","bitrate":192} Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::seek Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: error: null Oct 14 10:39:06 volumio volumio[1075]: info: Oct 14 10:39:06 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:06 volumio volumio[1075]: info: Oct 14 10:39:06 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:06 volumio volumio[1075]: info: Oct 14 10:39:06 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand status took 0 milliseconds Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526000,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:06 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:06 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526000,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:06 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:06 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: ------------------------------ 6ms Oct 14 10:39:06 volumio volumio[1075]: info: ------------------------------ 6ms Oct 14 10:39:06 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 14 10:39:06 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:06 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:06 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526000,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:06 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:06 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:06 volumio volumio[1075]: info: ------------------------------ 8ms Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:06 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:06 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioSeek Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::seek Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:08 volumio volumio[1075]: info: TRACKBLOCK {"id":"6689073:11644773@user:onyourwave","service":"yandex_music","type":"song","name":"Narayan","title":"Narayan","album":"The Fat of the Land - Expanded Edition","artist":"The Prodigy","duration":546,"albumart":"https://avatars.yandex.net/get-music-content/2433821/1272814a.a.11644773-1/200x200","uri":"yandex_music/track/6689073:11644773@user:onyourwave","samplerate":"","bitdepth":"","trackType":"","codec":"mp3","bitrate":192} Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::startPlaybackTimer Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:08 volumio volumio[1075]: info: ControllerMpd::seek Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:08 volumio volumio[1075]: error: null Oct 14 10:39:08 volumio volumio[1075]: info: Oct 14 10:39:08 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:08 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:08 volumio volumio[1075]: info: Oct 14 10:39:08 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:08 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:08 volumio volumio[1075]: info: Oct 14 10:39:08 volumio volumio[1075]: ---------------------------- MPD announces state update: player Oct 14 10:39:08 volumio volumio[1075]: info: ControllerMpd::getState Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand status Oct 14 10:39:08 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:39:08 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:39:08 volumio volumio[1075]: info: sendMpdCommand status took 1 milliseconds Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::parseState Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 14 10:39:08 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 14 10:39:08 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 14 10:39:08 volumio volumio[1075]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:08 volumio volumio[1075]: verbose: ControllerMpd::parseTrackInfo Oct 14 10:39:08 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:08 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28980,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:08 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:08 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:08 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:08 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28980,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:08 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:08 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:08 volumio volumio[1075]: info: ControllerMpd::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::servicePushState Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getTrack 21 Oct 14 10:39:08 volumio volumio[1075]: verbose: STATE SERVICE {"status":"play","position":0,"seek":28980,"duration":546,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Narayan","artist":"The Prodigy","album":"The Fat of the Land - Expanded Edition","uri":"https://api.music.yandex.net/get-mp3/6f2cacd1bb581af4f30c4c108e1db996/1a1399085b8/U2FsdGVkX19LVcd6WurTZDNgl9HTHHvieceT0sWHWzAv1F2ErQ18TocyC6qSXVEojjBKhjYWdGCH2zwzGk8C4MMa5d4ppyECJ4WIxz52cWXgRY2gHw3y7cNM_ni62G8KjsN6CSTEgCRzpHe1ZR6lrGt5nxh70klF1iGTR0KXH2KRlSEhhk0XMMFiYl_LnVlelqm--8k3CshNjUklK3gjdxq5qYmzunwrEjVed6sD5Cx-zM_VlZ4oaKdkycsMWXqdZdHb-GPJp8PGIqowl8-1pTBu5siHYOEaIxC31NNyBwIN980raCPjNteFRzdWxJ1tD3i5ZxDS2B9-xxyyDAcMJEOl8JeR6qJg2oO7-zL4lUd6NdaOmR2gPWarni6AouabLUTZUtWwpflSEYmyv1GTPrxzsyQFDSRo6wNXzm4wv1GFmmtr_VmK2KVMY2RacC5V-cZsZngXScOwzxjwLOu05hiE8b0X8iORZocrNXlxoi_jzH245xlynlypkPy5_OT2oeXvIzMJJQmpF_tHP3KvifzzjCpfWCdSWMeycLI_kzF8TaelWXmScgPp3tURFUML4RrFRfOUWGTfZkX4eWPtSkONkPn69ZVCu1RWPgxBLgjlMCqOdW_5QXtsikUMVqxUpXB4WkGlfX3AWMpIH3HDjErQ_wzFPc7nEQpOn9qUKDRPyl9hT9QBVEbWUwjOoqtaKN3FlRIhNUs5ukLD-B1iE1ewOxquAbB2IufHuwKn-wkPm01myRh-eIBJE9u4jxFx97qBlnof-w2eMnG2zQCZ_eSfXAlhlvwbr9lw4eRhXPobnr0wG0pttQNijT8ihpLuwVAxask0bchP9iBKo-yqC0nImQwl6OwnpQXDsI83P21s1He5sCxPz4KarzM1aKBFq9-IyNI5SuLfad3Cidi1YfYuWB592vwtaYmVHLbCcqDWmBkV-VMnOcQzxz7Cd-ZVHm_Xdmm6K1WM9DNSHzD5iw/4Phb1X2maY9Mu3RP2WiM_LiIcotkdlDZfT1wtWbboHA","trackType":""} Oct 14 10:39:08 volumio volumio[1075]: verbose: CURRENT POSITION 21 Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::syncState stateService play Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::syncState currentStatus play Oct 14 10:39:08 volumio volumio[1075]: info: Received an update from plugin. extracting info from payload Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::pushState Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioPushState Oct 14 10:39:08 volumio volumio[1075]: info: ------------------------------ 8ms Oct 14 10:39:08 volumio volumio[1075]: info: ------------------------------ 8ms Oct 14 10:39:08 volumio volumio[1075]: info: ------------------------------ 9ms Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreCommandRouter::volumioGetQueue Oct 14 10:39:08 volumio volumio[1075]: info: CoreStateMachine::getQueue Oct 14 10:39:08 volumio volumio[1075]: info: CorePlayQueue::getQueue Oct 14 10:39:11 volumio volumio[1075]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 10:39:11 volumio volumio[1075]: [t [Error]: A network error (such as timeout, interrupted connection or unreachable host) has occurred.] { Oct 14 10:39:11 volumio volumio[1075]: code: 'auth/network-request-failed', Oct 14 10:39:11 volumio volumio[1075]: a: null Oct 14 10:39:11 volumio volumio[1075]: } Oct 14 10:39:11 volumio volumio[1075]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 14 10:39:11 volumio sudo[17029]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-14 10:38' Oct 14 10:39:11 volumio sudo[17029]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:45:45 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6bf7cd61fe53483b72878254df87f1c0"