Jun 17 17:53:08 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: yandex_music , handleBrowseUri Jun 17 17:53:08 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 17 17:53:08 volumio dbus-daemon[876]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.69' (uid=0 pid=5620 comm="timedatectl show --property=NTPSynchronized --valu") Jun 17 17:53:08 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 17 17:53:08 volumio dbus-daemon[876]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 17 17:53:08 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 17 17:53:08 volumio setdatetime-helper.sh[5619]: Time is already synchronized. Jun 17 17:53:08 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 17 17:53:08 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 17 17:53:09 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Preloading song: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803291:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803292:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803293:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803294:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803295:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803296:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803297:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803302:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803308:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803311:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803316:11437669@11437669 in service yandex_music Jun 17 17:53:09 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803318:11437669@11437669 in service yandex_music Jun 17 17:53:10 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803319:11437669@11437669 in service yandex_music Jun 17 17:53:10 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803320:11437669@11437669 in service yandex_music Jun 17 17:53:10 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803321:11437669@11437669 in service yandex_music Jun 17 17:53:10 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803322:11437669@11437669 in service yandex_music Jun 17 17:53:10 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803324:11437669@11437669 in service yandex_music Jun 17 17:53:10 volumio volumio[1268]: info: Exploding uri yandex_music/track/68803325:11437669@11437669 in service yandex_music Jun 17 17:53:11 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::getTrack 32 Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::getTrack 32 Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:11 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:11 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::play index 0 Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:11 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:11 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:11 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:11 volumio volumio[1268]: info: Jun 17 17:53:11 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:11 volumio volumio[1268]: info: sendMpdCommand stop took 18 milliseconds Jun 17 17:53:11 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:11 volumio volumio[1268]: info: sendMpdCommand stop took 7 milliseconds Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:53:11 volumio volumio[1268]: info: Jun 17 17:53:11 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:11 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:11 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:53:11 volumio volumio[1268]: info: sendMpdCommand clear took 5 milliseconds Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:11 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:53:11 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:11 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:11 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:53:11 volumio volumio[1268]: info: ------------------------------ 14ms Jun 17 17:53:11 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac" Jun 17 17:53:11 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac" took 0 milliseconds Jun 17 17:53:11 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:11 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:11 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:11 volumio volumio[1268]: info: Jun 17 17:53:11 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:11 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:11 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:11 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:53:11 volumio volumio[1268]: info: Jun 17 17:53:11 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:11 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:11 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:11 volumio volumio[1268]: info: sendMpdCommand play took 0 milliseconds Jun 17 17:53:11 volumio volumio[1268]: info: ------------------------------ 0ms Jun 17 17:53:12 volumio volumio[1268]: info: Jun 17 17:53:12 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:12 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:12 volumio volumio[1268]: info: Jun 17 17:53:12 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:12 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:53:12 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:12 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:53:12 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:12 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:12 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:12 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:53:12 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:12 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:53:12 volumio volumio[1268]: info: ------------------------------ 7ms Jun 17 17:53:12 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:12 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:12 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:12 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:12 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:53:12 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:12 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:12 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:12 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:12 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:12 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:12 volumio volumio[1268]: info: ------------------------------ 5ms Jun 17 17:53:12 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:12 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:12 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:12 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:12 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:12 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:53:14 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:14 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:53:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:14 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::play index 1 Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:14 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:14 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::getTrack 1 Jun 17 17:53:14 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:14 volumio volumio[1268]: info: CorePlayQueue::getTrack 1 Jun 17 17:53:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:14 volumio volumio[1268]: info: Jun 17 17:53:14 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:14 volumio volumio[1268]: info: sendMpdCommand stop took 41 milliseconds Jun 17 17:53:14 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:14 volumio volumio[1268]: info: sendMpdCommand stop took 17 milliseconds Jun 17 17:53:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:53:14 volumio volumio[1268]: info: Jun 17 17:53:14 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:14 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:14 volumio volumio[1268]: info: sendMpdCommand status took 7 milliseconds Jun 17 17:53:14 volumio volumio[1268]: info: sendMpdCommand clear took 7 milliseconds Jun 17 17:53:14 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:14 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:53:14 volumio volumio[1268]: info: ------------------------------ 11ms Jun 17 17:53:14 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 17 17:53:14 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:14 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:53:14 volumio volumio[1268]: info: ------------------------------ 26ms Jun 17 17:53:14 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-65.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6ba5bffe80f2b8633ebf053a7e5d83fac1d680b0b1cf587b68651188a889681a%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685eda29%2F0%2F21076%2Fc985c06a.103479594.21.68803292%2Fflac-mp4&ext=.flac" Jun 17 17:53:15 volumio volumio[1268]: info: Jun 17 17:53:15 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:15 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:15 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-65.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6ba5bffe80f2b8633ebf053a7e5d83fac1d680b0b1cf587b68651188a889681a%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685eda29%2F0%2F21076%2Fc985c06a.103479594.21.68803292%2Fflac-mp4&ext=.flac" took 0 milliseconds Jun 17 17:53:15 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:15 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:15 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:15 volumio volumio[1268]: info: Jun 17 17:53:15 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:15 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:15 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:53:15 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:15 volumio volumio[1268]: info: sendMpdCommand play took 1 milliseconds Jun 17 17:53:15 volumio volumio[1268]: info: Jun 17 17:53:15 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:15 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:15 volumio volumio[1268]: info: sendMpdCommand status took 4 milliseconds Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:15 volumio volumio[1268]: info: Jun 17 17:53:15 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:15 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:15 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:15 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:15 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:15 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:15 volumio volumio[1268]: info: CorePlayQueue::getTrack 1 Jun 17 17:53:15 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Блеск в её глазах","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-65.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6ba5bffe80f2b8633ebf053a7e5d83fac1d680b0b1cf587b68651188a889681a%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685eda29%2F0%2F21076%2Fc985c06a.103479594.21.68803292%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:15 volumio volumio[1268]: verbose: CURRENT POSITION 1 Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:53:15 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:15 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:15 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:15 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:15 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:15 volumio volumio[1268]: info: CorePlayQueue::getTrack 1 Jun 17 17:53:15 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":229,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Блеск в её глазах","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-65.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6ba5bffe80f2b8633ebf053a7e5d83fac1d680b0b1cf587b68651188a889681a%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685eda29%2F0%2F21076%2Fc985c06a.103479594.21.68803292%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:15 volumio volumio[1268]: verbose: CURRENT POSITION 1 Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:15 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:15 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:15 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:15 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:15 volumio volumio[1268]: info: ------------------------------ 5ms Jun 17 17:53:15 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:15 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:15 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:15 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:15 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:15 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:53:18 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::getTrack 1 Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::getTrack 1 Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:18 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:18 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::play index 11 Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:18 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:18 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:18 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:18 volumio volumio[1268]: info: Jun 17 17:53:18 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:18 volumio volumio[1268]: info: sendMpdCommand stop took 15 milliseconds Jun 17 17:53:18 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:18 volumio volumio[1268]: info: sendMpdCommand stop took 4 milliseconds Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:53:18 volumio volumio[1268]: info: Jun 17 17:53:18 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:18 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:18 volumio volumio[1268]: info: sendMpdCommand status took 18 milliseconds Jun 17 17:53:18 volumio volumio[1268]: info: sendMpdCommand clear took 17 milliseconds Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:18 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:53:18 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:18 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:18 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:53:18 volumio volumio[1268]: info: ------------------------------ 23ms Jun 17 17:53:18 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D70cafffa98f674f2bf7870556ec5092a5eb7ad32fea610a43c619196db7df26c%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f4605%2F0%2F928045%2F76f58589.103479620.20.68803318%2Fflac-mp4&ext=.flac" Jun 17 17:53:18 volumio volumio[1268]: info: Jun 17 17:53:18 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:18 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:18 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D70cafffa98f674f2bf7870556ec5092a5eb7ad32fea610a43c619196db7df26c%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f4605%2F0%2F928045%2F76f58589.103479620.20.68803318%2Fflac-mp4&ext=.flac" took 1 milliseconds Jun 17 17:53:18 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:18 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:18 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:18 volumio volumio[1268]: info: Jun 17 17:53:18 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:18 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:18 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:18 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:18 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:53:18 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:18 volumio volumio[1268]: info: sendMpdCommand play took 0 milliseconds Jun 17 17:53:19 volumio volumio[1268]: info: Jun 17 17:53:19 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:19 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:19 volumio volumio[1268]: info: Jun 17 17:53:19 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:19 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:53:19 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:19 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:53:19 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:19 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:19 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:19 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:19 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Золотая карусель","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D70cafffa98f674f2bf7870556ec5092a5eb7ad32fea610a43c619196db7df26c%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f4605%2F0%2F928045%2F76f58589.103479620.20.68803318%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:19 volumio volumio[1268]: verbose: CURRENT POSITION 11 Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:53:19 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:19 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:53:19 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:19 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:19 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:19 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:19 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Золотая карусель","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D70cafffa98f674f2bf7870556ec5092a5eb7ad32fea610a43c619196db7df26c%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f4605%2F0%2F928045%2F76f58589.103479620.20.68803318%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:19 volumio volumio[1268]: verbose: CURRENT POSITION 11 Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:19 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:19 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:19 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:19 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:19 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:19 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:19 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:19 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:19 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:19 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:19 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:53:23 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:23 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803318:11437669@11437669","service":"yandex_music","type":"song","name":"Золотая карусель","title":"Золотая карусель","album":"Две звезды","artist":"Алла Пугачёва","duration":215,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803318:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:23 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:23 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:23 volumio volumio[1268]: error: null Jun 17 17:53:23 volumio volumio[1268]: info: Jun 17 17:53:23 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:23 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:23 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:23 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:23 volumio volumio[1268]: info: sendMpdCommand status took 10 milliseconds Jun 17 17:53:23 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:23 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:23 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:23 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:23 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:23 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:23 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":94000,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"844 Kbps","isStreaming":false,"title":"Золотая карусель","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D70cafffa98f674f2bf7870556ec5092a5eb7ad32fea610a43c619196db7df26c%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f4605%2F0%2F928045%2F76f58589.103479620.20.68803318%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:23 volumio volumio[1268]: verbose: CURRENT POSITION 11 Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:23 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:23 volumio volumio[1268]: info: ------------------------------ 18ms Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:23 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:23 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:23 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:23 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:25 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 17:53:25 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 17:53:25 volumio volumio[1268]: info: Discovery: Getting this device information Jun 17 17:53:25 volumio volumio[1268]: info: CoreCommandRouter::volumioGetState Jun 17 17:53:25 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:53:31 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:31 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803318:11437669@11437669","service":"yandex_music","type":"song","name":"Золотая карусель","title":"Золотая карусель","album":"Две звезды","artist":"Алла Пугачёва","duration":215,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803318:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:31 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:31 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:31 volumio volumio[1268]: error: null Jun 17 17:53:31 volumio volumio[1268]: info: Jun 17 17:53:31 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:31 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:31 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:31 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:31 volumio volumio[1268]: info: sendMpdCommand status took 6 milliseconds Jun 17 17:53:31 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:31 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:31 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:31 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:31 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:31 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:31 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":150000,"duration":215,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"844 Kbps","isStreaming":false,"title":"Золотая карусель","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-19.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D70cafffa98f674f2bf7870556ec5092a5eb7ad32fea610a43c619196db7df26c%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f4605%2F0%2F928045%2F76f58589.103479620.20.68803318%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:31 volumio volumio[1268]: verbose: CURRENT POSITION 11 Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:31 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:31 volumio volumio[1268]: info: ------------------------------ 10ms Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:31 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:31 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:31 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:31 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:32 volumio volumio[1268]: info: CoreCommandRouter::volumioNext Jun 17 17:53:32 volumio volumio[1268]: info: CoreStateMachine::next Jun 17 17:53:32 volumio volumio[1268]: info: ControllerMpd::next Jun 17 17:53:32 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand next Jun 17 17:53:32 volumio volumio[1268]: info: sendMpdCommand next took 6 milliseconds Jun 17 17:53:32 volumio volumio[1268]: info: Jun 17 17:53:32 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:32 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:32 volumio volumio[1268]: info: Jun 17 17:53:32 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:32 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:32 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:32 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:53:32 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:32 volumio volumio[1268]: info: sendMpdCommand status took 1 milliseconds Jun 17 17:53:32 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:32 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:32 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:32 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:32 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:32 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:32 volumio volumio[1268]: info: CorePlayQueue::getTrack 11 Jun 17 17:53:32 volumio volumio[1268]: 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} Jun 17 17:53:32 volumio volumio[1268]: verbose: CURRENT POSITION 11 Jun 17 17:53:32 volumio volumio[1268]: info: CoreStateMachine::syncState stateService stop Jun 17 17:53:32 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:32 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:32 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:53:32 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:32 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:32 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:32 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:32 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:53:34 volumio volumio[1268]: info: CoreCommandRouter::volumioPrevious Jun 17 17:53:34 volumio volumio[1268]: info: CoreStateMachine::previous Jun 17 17:53:34 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:34 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:34 volumio volumio[1268]: info: CoreStateMachine::serviceClearAddPlay Jun 17 17:53:34 volumio volumio[1268]: info: CoreCommandRouter::serviceClearAddPlayTracks Jun 17 17:53:34 volumio volumio[1268]: error: WARNING: No clearAddPlayTracks method for service yandex_music Jun 17 17:53:38 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:38 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:38 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:38 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:38 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::play index 15 Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:38 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:38 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::getTrack 15 Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:38 volumio volumio[1268]: info: CorePlayQueue::getTrack 15 Jun 17 17:53:38 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:38 volumio volumio[1268]: info: sendMpdCommand stop took 2 milliseconds Jun 17 17:53:38 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:53:38 volumio volumio[1268]: info: Jun 17 17:53:38 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:38 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:38 volumio volumio[1268]: info: sendMpdCommand clear took 0 milliseconds Jun 17 17:53:38 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:53:38 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:38 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-168.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D15824d82bfab25f25ac26b13f9cb2e0c5d8d4f73be37259057331afe52489467%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f104a%2F0%2F1665660%2Fadd3025e.103479625.20.68803322%2Fflac-mp4&ext=.flac" Jun 17 17:53:38 volumio volumio[1268]: info: Jun 17 17:53:38 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:38 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:38 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-168.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D15824d82bfab25f25ac26b13f9cb2e0c5d8d4f73be37259057331afe52489467%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f104a%2F0%2F1665660%2Fadd3025e.103479625.20.68803322%2Fflac-mp4&ext=.flac" took 1 milliseconds Jun 17 17:53:38 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:38 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:38 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:38 volumio volumio[1268]: info: Jun 17 17:53:38 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:38 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:38 volumio volumio[1268]: info: ------------------------------ 2ms Jun 17 17:53:38 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:38 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:53:38 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:38 volumio volumio[1268]: info: sendMpdCommand play took 1 milliseconds Jun 17 17:53:38 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 17 17:53:39 volumio volumio[1268]: info: Jun 17 17:53:39 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:39 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:39 volumio volumio[1268]: info: Jun 17 17:53:39 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:39 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:53:39 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:39 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:53:39 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:39 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:39 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:39 volumio volumio[1268]: info: CorePlayQueue::getTrack 15 Jun 17 17:53:39 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Вы так невинны","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-168.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D15824d82bfab25f25ac26b13f9cb2e0c5d8d4f73be37259057331afe52489467%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f104a%2F0%2F1665660%2Fadd3025e.103479625.20.68803322%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:39 volumio volumio[1268]: verbose: CURRENT POSITION 15 Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:53:39 volumio volumio[1268]: info: ------------------------------ 7ms Jun 17 17:53:39 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:39 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:39 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:39 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:39 volumio volumio[1268]: info: CorePlayQueue::getTrack 15 Jun 17 17:53:39 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":217,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Вы так невинны","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-168.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D15824d82bfab25f25ac26b13f9cb2e0c5d8d4f73be37259057331afe52489467%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f104a%2F0%2F1665660%2Fadd3025e.103479625.20.68803322%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:39 volumio volumio[1268]: verbose: CURRENT POSITION 15 Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:39 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:39 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:39 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:39 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:39 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:39 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:39 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:39 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:39 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:39 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:39 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:53:42 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::getTrack 15 Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::getTrack 15 Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:42 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:42 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::play index 16 Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:42 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:42 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:42 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:42 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:42 volumio volumio[1268]: info: Jun 17 17:53:42 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:42 volumio volumio[1268]: info: sendMpdCommand stop took 15 milliseconds Jun 17 17:53:42 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:42 volumio volumio[1268]: info: sendMpdCommand stop took 2 milliseconds Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:53:42 volumio volumio[1268]: info: Jun 17 17:53:42 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:42 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:42 volumio volumio[1268]: info: sendMpdCommand status took 2 milliseconds Jun 17 17:53:42 volumio volumio[1268]: info: sendMpdCommand clear took 2 milliseconds Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:42 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:53:42 volumio volumio[1268]: info: ------------------------------ 14ms Jun 17 17:53:42 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:42 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:53:42 volumio volumio[1268]: info: ------------------------------ 16ms Jun 17 17:53:42 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-40.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D178aa87acf3129a24351463664f96b31482b1a19af692eea38a499d7b7800ee0%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685ec62f%2F0%2F1618234%2F55cab206.103479627.21.68803324%2Fflac-mp4&ext=.flac" Jun 17 17:53:42 volumio volumio[1268]: info: Jun 17 17:53:42 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:42 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:42 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-40.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D178aa87acf3129a24351463664f96b31482b1a19af692eea38a499d7b7800ee0%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685ec62f%2F0%2F1618234%2F55cab206.103479627.21.68803324%2Fflac-mp4&ext=.flac" took 2 milliseconds Jun 17 17:53:42 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:42 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:42 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:42 volumio volumio[1268]: info: Jun 17 17:53:42 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:42 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:42 volumio volumio[1268]: info: ------------------------------ 2ms Jun 17 17:53:42 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:42 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:53:42 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:42 volumio volumio[1268]: info: sendMpdCommand play took 1 milliseconds Jun 17 17:53:43 volumio volumio[1268]: info: Jun 17 17:53:43 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:43 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:43 volumio volumio[1268]: info: Jun 17 17:53:43 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:43 volumio volumio[1268]: info: sendMpdCommand status took 3 milliseconds Jun 17 17:53:43 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:43 volumio volumio[1268]: info: sendMpdCommand status took 1 milliseconds Jun 17 17:53:43 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:43 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:43 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:43 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:43 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Когда меня ты позовёшь","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-40.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D178aa87acf3129a24351463664f96b31482b1a19af692eea38a499d7b7800ee0%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685ec62f%2F0%2F1618234%2F55cab206.103479627.21.68803324%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:43 volumio volumio[1268]: verbose: CURRENT POSITION 16 Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:53:43 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:43 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:53:43 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:43 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:43 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:43 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:43 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Когда меня ты позовёшь","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-40.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D178aa87acf3129a24351463664f96b31482b1a19af692eea38a499d7b7800ee0%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685ec62f%2F0%2F1618234%2F55cab206.103479627.21.68803324%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:43 volumio volumio[1268]: verbose: CURRENT POSITION 16 Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:43 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:43 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:43 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:43 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:43 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:53:43 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:43 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:43 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:43 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:43 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:43 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:53:45 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:45 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803324:11437669@11437669","service":"yandex_music","type":"song","name":"Когда меня ты позовёшь","title":"Когда меня ты позовёшь","album":"Две звезды","artist":"Алла Пугачёва","duration":316,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803324:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:45 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:45 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:45 volumio volumio[1268]: error: null Jun 17 17:53:45 volumio volumio[1268]: info: Jun 17 17:53:45 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:45 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:45 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:45 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:45 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:53:45 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:45 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:45 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 17 17:53:45 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:45 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:45 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:45 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":117000,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"876 Kbps","isStreaming":false,"title":"Когда меня ты позовёшь","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-40.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D178aa87acf3129a24351463664f96b31482b1a19af692eea38a499d7b7800ee0%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685ec62f%2F0%2F1618234%2F55cab206.103479627.21.68803324%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:45 volumio volumio[1268]: verbose: CURRENT POSITION 16 Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:45 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:45 volumio volumio[1268]: info: ------------------------------ 27ms Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:45 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:45 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:45 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:45 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:53:48 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:48 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803324:11437669@11437669","service":"yandex_music","type":"song","name":"Когда меня ты позовёшь","title":"Когда меня ты позовёшь","album":"Две звезды","artist":"Алла Пугачёва","duration":316,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803324:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:48 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:48 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:48 volumio volumio[1268]: error: null Jun 17 17:53:48 volumio volumio[1268]: info: Jun 17 17:53:48 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:48 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:48 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:48 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:48 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:53:48 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:48 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:48 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:53:48 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:48 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:48 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:48 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":188000,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"876 Kbps","isStreaming":false,"title":"Когда меня ты позовёшь","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-40.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D178aa87acf3129a24351463664f96b31482b1a19af692eea38a499d7b7800ee0%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685ec62f%2F0%2F1618234%2F55cab206.103479627.21.68803324%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:48 volumio volumio[1268]: verbose: CURRENT POSITION 16 Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:48 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:48 volumio volumio[1268]: info: ------------------------------ 8ms Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:48 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:48 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:48 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:48 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:53:50 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:50 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803324:11437669@11437669","service":"yandex_music","type":"song","name":"Когда меня ты позовёшь","title":"Когда меня ты позовёшь","album":"Две звезды","artist":"Алла Пугачёва","duration":316,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803324:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:50 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:50 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:50 volumio volumio[1268]: error: null Jun 17 17:53:50 volumio volumio[1268]: info: Jun 17 17:53:50 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:50 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:50 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:50 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:50 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:53:50 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:50 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:50 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:50 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:50 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:50 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:50 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":238000,"duration":316,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"876 Kbps","isStreaming":false,"title":"Когда меня ты позовёшь","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-40.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D178aa87acf3129a24351463664f96b31482b1a19af692eea38a499d7b7800ee0%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685ec62f%2F0%2F1618234%2F55cab206.103479627.21.68803324%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:50 volumio volumio[1268]: verbose: CURRENT POSITION 16 Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:50 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:50 volumio volumio[1268]: info: ------------------------------ 10ms Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:50 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:50 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:50 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:50 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:54 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:54 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:54 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:54 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::getTrack 16 Jun 17 17:53:54 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:54 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:53:54 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:54 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:53:54 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:53:54 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:53:54 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::play index 17 Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:54 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:54 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:54 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:53:54 volumio volumio[1268]: info: Jun 17 17:53:54 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:54 volumio volumio[1268]: info: sendMpdCommand stop took 21 milliseconds Jun 17 17:53:54 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:54 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:54 volumio volumio[1268]: info: sendMpdCommand stop took 14 milliseconds Jun 17 17:53:54 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:53:54 volumio volumio[1268]: info: Jun 17 17:53:54 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:54 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:54 volumio volumio[1268]: info: sendMpdCommand status took 2 milliseconds Jun 17 17:53:54 volumio volumio[1268]: info: sendMpdCommand clear took 2 milliseconds Jun 17 17:53:54 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:54 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:54 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:53:54 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:53:54 volumio volumio[1268]: info: ------------------------------ 7ms Jun 17 17:53:54 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 17 17:53:54 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:54 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:53:54 volumio volumio[1268]: info: ------------------------------ 9ms Jun 17 17:53:55 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 17:53:55 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 17:53:55 volumio volumio[1268]: info: Discovery: Getting this device information Jun 17 17:53:55 volumio volumio[1268]: info: CoreCommandRouter::volumioGetState Jun 17 17:53:55 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:55 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 17:53:55 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bc5ab11d0062dc616c238c34b3969514715127696f0acbce2b8d4d4eda9eaa2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685efa9a%2F0%2F4949639%2Fb96a0c02.103479628.20.68803325%2Fflac-mp4&ext=.flac" Jun 17 17:53:55 volumio volumio[1268]: info: Jun 17 17:53:55 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:55 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:55 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bc5ab11d0062dc616c238c34b3969514715127696f0acbce2b8d4d4eda9eaa2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685efa9a%2F0%2F4949639%2Fb96a0c02.103479628.20.68803325%2Fflac-mp4&ext=.flac" took 0 milliseconds Jun 17 17:53:55 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:55 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:55 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:53:55 volumio volumio[1268]: info: Jun 17 17:53:55 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:53:55 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:53:55 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:53:55 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:53:55 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:53:55 volumio volumio[1268]: info: ------------------------------ 0ms Jun 17 17:53:55 volumio volumio[1268]: info: sendMpdCommand play took 0 milliseconds Jun 17 17:53:56 volumio volumio[1268]: info: Jun 17 17:53:56 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:56 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:56 volumio volumio[1268]: info: Jun 17 17:53:56 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:56 volumio volumio[1268]: info: sendMpdCommand status took 4 milliseconds Jun 17 17:53:56 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:56 volumio volumio[1268]: info: sendMpdCommand status took 1 milliseconds Jun 17 17:53:56 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:56 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:56 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:56 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:56 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Мечты","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bc5ab11d0062dc616c238c34b3969514715127696f0acbce2b8d4d4eda9eaa2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685efa9a%2F0%2F4949639%2Fb96a0c02.103479628.20.68803325%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:56 volumio volumio[1268]: verbose: CURRENT POSITION 17 Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:53:56 volumio volumio[1268]: info: ------------------------------ 5ms Jun 17 17:53:56 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:53:56 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:56 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:56 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:56 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:56 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Мечты","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bc5ab11d0062dc616c238c34b3969514715127696f0acbce2b8d4d4eda9eaa2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685efa9a%2F0%2F4949639%2Fb96a0c02.103479628.20.68803325%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:56 volumio volumio[1268]: verbose: CURRENT POSITION 17 Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:56 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:56 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:56 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:56 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:56 volumio volumio[1268]: info: ------------------------------ 5ms Jun 17 17:53:56 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:56 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:56 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:56 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:56 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:56 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:53:57 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:57 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803325:11437669@11437669","service":"yandex_music","type":"song","name":"Мечты","title":"Мечты","album":"Две звезды","artist":"Алла Пугачёва","duration":233,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803325:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:53:57 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:57 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:57 volumio volumio[1268]: error: null Jun 17 17:53:57 volumio volumio[1268]: info: Jun 17 17:53:57 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:53:57 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:53:57 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:57 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:57 volumio volumio[1268]: info: sendMpdCommand status took 4 milliseconds Jun 17 17:53:57 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:53:57 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:53:57 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:53:57 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:53:57 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:53:57 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:53:57 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107000,"duration":233,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"969 Kbps","isStreaming":false,"title":"Мечты","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-100.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D6bc5ab11d0062dc616c238c34b3969514715127696f0acbce2b8d4d4eda9eaa2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685efa9a%2F0%2F4949639%2Fb96a0c02.103479628.20.68803325%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:53:57 volumio volumio[1268]: verbose: CURRENT POSITION 17 Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:53:57 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:53:57 volumio volumio[1268]: info: ------------------------------ 8ms Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:57 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:53:57 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:53:57 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:53:57 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:02 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::getTrack 17 Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:02 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:54:02 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:54:02 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::play index 13 Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:54:02 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:02 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:02 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:02 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:02 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:54:02 volumio volumio[1268]: info: Jun 17 17:54:02 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:02 volumio volumio[1268]: info: sendMpdCommand stop took 20 milliseconds Jun 17 17:54:02 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:02 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:02 volumio volumio[1268]: info: sendMpdCommand stop took 12 milliseconds Jun 17 17:54:02 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:54:02 volumio volumio[1268]: info: Jun 17 17:54:02 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:02 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:02 volumio volumio[1268]: info: sendMpdCommand status took 3 milliseconds Jun 17 17:54:02 volumio volumio[1268]: info: sendMpdCommand clear took 3 milliseconds Jun 17 17:54:02 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:02 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:02 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:54:02 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:54:02 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 17 17:54:02 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:02 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:54:02 volumio volumio[1268]: info: ------------------------------ 9ms Jun 17 17:54:02 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:54:03 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-25.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd7da2fb2c51b066cd522ac6eae887ad84909c9582ad262e4b8ed047b9e450ca1%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f9006%2F0%2F12719553%2Fc9d0e0d5.103479623.20.68803320%2Fflac-mp4&ext=.flac" Jun 17 17:54:03 volumio volumio[1268]: info: Jun 17 17:54:03 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:03 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:03 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-25.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd7da2fb2c51b066cd522ac6eae887ad84909c9582ad262e4b8ed047b9e450ca1%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f9006%2F0%2F12719553%2Fc9d0e0d5.103479623.20.68803320%2Fflac-mp4&ext=.flac" took 1 milliseconds Jun 17 17:54:03 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:03 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:03 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:03 volumio volumio[1268]: info: Jun 17 17:54:03 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:03 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:03 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:54:03 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:03 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:54:03 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:54:03 volumio volumio[1268]: info: sendMpdCommand play took 1 milliseconds Jun 17 17:54:04 volumio volumio[1268]: info: Jun 17 17:54:04 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:04 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:04 volumio volumio[1268]: info: Jun 17 17:54:04 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:04 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:54:04 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:04 volumio volumio[1268]: info: sendMpdCommand status took 1 milliseconds Jun 17 17:54:04 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:04 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:04 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:04 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:04 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Птица певчая","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-25.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd7da2fb2c51b066cd522ac6eae887ad84909c9582ad262e4b8ed047b9e450ca1%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f9006%2F0%2F12719553%2Fc9d0e0d5.103479623.20.68803320%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:04 volumio volumio[1268]: verbose: CURRENT POSITION 13 Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:54:04 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:54:04 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:54:04 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:04 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:04 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:04 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:04 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Птица певчая","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-25.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd7da2fb2c51b066cd522ac6eae887ad84909c9582ad262e4b8ed047b9e450ca1%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f9006%2F0%2F12719553%2Fc9d0e0d5.103479623.20.68803320%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:04 volumio volumio[1268]: verbose: CURRENT POSITION 13 Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:54:04 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:04 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:04 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:04 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:04 volumio volumio[1268]: info: ------------------------------ 5ms Jun 17 17:54:04 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:04 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:04 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:04 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:04 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:04 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:54:06 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:06 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803320:11437669@11437669","service":"yandex_music","type":"song","name":"Птица певчая","title":"Птица певчая","album":"Две звезды","artist":"Алла Пугачёва","duration":254,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803320:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:06 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:06 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:06 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:06 volumio volumio[1268]: error: null Jun 17 17:54:06 volumio volumio[1268]: info: Jun 17 17:54:06 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:06 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:06 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:06 volumio volumio[1268]: info: sendMpdCommand status took 1 milliseconds Jun 17 17:54:06 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:06 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:06 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:54:06 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:06 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:06 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:06 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100000,"duration":254,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"940 Kbps","isStreaming":false,"title":"Птица певчая","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-25.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dd7da2fb2c51b066cd522ac6eae887ad84909c9582ad262e4b8ed047b9e450ca1%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f9006%2F0%2F12719553%2Fc9d0e0d5.103479623.20.68803320%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:06 volumio volumio[1268]: verbose: CURRENT POSITION 13 Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:54:06 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:06 volumio volumio[1268]: info: ------------------------------ 7ms Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:06 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:06 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:06 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:06 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:13 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::getTrack 13 Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:13 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:54:13 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::play index 7 Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:54:13 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:13 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:13 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:54:13 volumio volumio[1268]: info: Jun 17 17:54:13 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:13 volumio volumio[1268]: info: sendMpdCommand stop took 14 milliseconds Jun 17 17:54:13 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:13 volumio volumio[1268]: info: sendMpdCommand stop took 7 milliseconds Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:54:13 volumio volumio[1268]: info: Jun 17 17:54:13 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:13 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:13 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:54:13 volumio volumio[1268]: info: sendMpdCommand clear took 0 milliseconds Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:13 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:54:13 volumio volumio[1268]: info: ------------------------------ 11ms Jun 17 17:54:13 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 11 milliseconds Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:13 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:54:13 volumio volumio[1268]: info: ------------------------------ 12ms Jun 17 17:54:13 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D025538f7f1f1d10bc414494b48d15ea32f971cfb9b826bed1a16d0be48ebdc21%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f7980%2F0%2F39280%2F1a679052.103479606.20.68803302%2Fflac-mp4&ext=.flac" Jun 17 17:54:13 volumio volumio[1268]: info: Jun 17 17:54:13 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:13 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:13 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D025538f7f1f1d10bc414494b48d15ea32f971cfb9b826bed1a16d0be48ebdc21%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f7980%2F0%2F39280%2F1a679052.103479606.20.68803302%2Fflac-mp4&ext=.flac" took 0 milliseconds Jun 17 17:54:13 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:13 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:13 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:13 volumio volumio[1268]: info: Jun 17 17:54:13 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:13 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:13 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:54:13 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:13 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:54:13 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:54:13 volumio volumio[1268]: info: sendMpdCommand play took 0 milliseconds Jun 17 17:54:14 volumio volumio[1268]: info: Jun 17 17:54:14 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:14 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:14 volumio volumio[1268]: info: Jun 17 17:54:14 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:14 volumio volumio[1268]: info: sendMpdCommand status took 4 milliseconds Jun 17 17:54:14 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:14 volumio volumio[1268]: info: sendMpdCommand status took 1 milliseconds Jun 17 17:54:14 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:14 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:14 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:14 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:14 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Две звезды","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D025538f7f1f1d10bc414494b48d15ea32f971cfb9b826bed1a16d0be48ebdc21%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f7980%2F0%2F39280%2F1a679052.103479606.20.68803302%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:14 volumio volumio[1268]: verbose: CURRENT POSITION 7 Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:54:14 volumio volumio[1268]: info: ------------------------------ 7ms Jun 17 17:54:14 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:14 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:14 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:14 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:14 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:14 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Две звезды","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D025538f7f1f1d10bc414494b48d15ea32f971cfb9b826bed1a16d0be48ebdc21%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f7980%2F0%2F39280%2F1a679052.103479606.20.68803302%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:14 volumio volumio[1268]: verbose: CURRENT POSITION 7 Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:54:14 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:14 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:14 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:14 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:14 volumio volumio[1268]: info: ------------------------------ 7ms Jun 17 17:54:14 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:14 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:14 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:14 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:14 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:14 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:54:15 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:54:15 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:54:15 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:15 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803302:11437669@11437669","service":"yandex_music","type":"song","name":"Две звезды","title":"Две звезды","album":"Две звезды","artist":"Алла Пугачёва","duration":235,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803302:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:54:15 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:15 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:15 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:54:15 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:15 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:15 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:15 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:15 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:15 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:16 volumio volumio[1268]: error: null Jun 17 17:54:16 volumio volumio[1268]: info: Jun 17 17:54:16 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:16 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:16 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:16 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:54:16 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:16 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:16 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 0 milliseconds Jun 17 17:54:16 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:16 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:16 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:16 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:16 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":107000,"duration":235,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"988 Kbps","isStreaming":false,"title":"Две звезды","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-26.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3D025538f7f1f1d10bc414494b48d15ea32f971cfb9b826bed1a16d0be48ebdc21%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f7980%2F0%2F39280%2F1a679052.103479606.20.68803302%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:16 volumio volumio[1268]: verbose: CURRENT POSITION 7 Jun 17 17:54:16 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:16 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:54:16 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:54:16 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:16 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:16 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:16 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:16 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:16 volumio volumio[1268]: info: ------------------------------ 3ms Jun 17 17:54:16 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:16 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:16 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:16 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:16 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:16 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:25 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 17 17:54:25 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 17 17:54:25 volumio volumio[1268]: info: Discovery: Getting this device information Jun 17 17:54:25 volumio volumio[1268]: info: CoreCommandRouter::volumioGetState Jun 17 17:54:25 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 17 17:54:26 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::ClearQueue Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::serviceStop Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::getTrack 7 Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::serviceStop Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:26 volumio volumio[1268]: info: ControllerMpd::stop Jun 17 17:54:26 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::clearPlayQueue Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:54:26 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803291:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803291:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::play index 0 Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::addQueueItems Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::addQueueItems Jun 17 17:54:26 volumio volumio[1268]: info: Preload queue cleared Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803292:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803292:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803293:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803293:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803294:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803294:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803295:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803295:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803296:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803296:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803297:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803297:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803302:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803302:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803308:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803308:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803311:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803311:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803316:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803316:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803318:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803318:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803319:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803319:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803320:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803320:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803321:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803321:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803322:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803322:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803324:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803324:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Adding Item to queue: yandex_music/track/68803325:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: Using cached record of: yandex_music/track/68803325:11437669@11437669 Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::stop Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:26 volumio volumio[1268]: info: CoreCommandRouter::volumioPushQueue Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::saveQueue Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::updateTrackBlock Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::getTrackBlock Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:26 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:26 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:26 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand stop Jun 17 17:54:26 volumio volumio[1268]: info: Jun 17 17:54:26 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:26 volumio volumio[1268]: info: sendMpdCommand stop took 22 milliseconds Jun 17 17:54:26 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:26 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:26 volumio volumio[1268]: info: sendMpdCommand stop took 12 milliseconds Jun 17 17:54:26 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand clear Jun 17 17:54:26 volumio volumio[1268]: info: Jun 17 17:54:26 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:26 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:26 volumio volumio[1268]: info: sendMpdCommand status took 4 milliseconds Jun 17 17:54:26 volumio volumio[1268]: info: sendMpdCommand clear took 4 milliseconds Jun 17 17:54:26 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:26 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:26 volumio volumio[1268]: error: updateQueue error: null Jun 17 17:54:26 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:54:26 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 6 milliseconds Jun 17 17:54:26 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:26 volumio volumio[1268]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Jun 17 17:54:26 volumio volumio[1268]: info: ------------------------------ 11ms Jun 17 17:54:26 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac" Jun 17 17:54:27 volumio volumio[1268]: info: Jun 17 17:54:27 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:27 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:27 volumio volumio[1268]: info: sendMpdCommand addid "http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac" took 1 milliseconds Jun 17 17:54:27 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:27 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:27 volumio volumio[1268]: verbose: MPD COMMAND [object Object] Jun 17 17:54:27 volumio volumio[1268]: info: Jun 17 17:54:27 volumio volumio[1268]: ---------------------------- MPD announces system playlist update Jun 17 17:54:27 volumio volumio[1268]: info: Ignoring MPD Status Update Jun 17 17:54:27 volumio volumio[1268]: info: ------------------------------ 2ms Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:54:27 volumio volumio[1268]: info: ------------------------------ 1ms Jun 17 17:54:27 volumio volumio[1268]: info: sendMpdCommand play took 1 milliseconds Jun 17 17:54:27 volumio volumio[1268]: info: Jun 17 17:54:27 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:27 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:27 volumio volumio[1268]: info: Jun 17 17:54:27 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:27 volumio volumio[1268]: info: sendMpdCommand status took 4 milliseconds Jun 17 17:54:27 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:27 volumio volumio[1268]: info: sendMpdCommand status took 1 milliseconds Jun 17 17:54:27 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:27 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:27 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:27 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:27 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:27 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus stop Jun 17 17:54:27 volumio volumio[1268]: info: ------------------------------ 6ms Jun 17 17:54:27 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:27 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:27 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:27 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:27 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:27 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:27 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:54:27 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:27 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:27 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:27 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:27 volumio volumio[1268]: info: ------------------------------ 8ms Jun 17 17:54:27 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:27 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:27 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:27 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:27 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:27 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:54:28 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 17 17:54:28 volumio dbus-daemon[876]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.71' (uid=0 pid=5813 comm="timedatectl show --property=NTPSynchronized --valu") Jun 17 17:54:28 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 17 17:54:28 volumio dbus-daemon[876]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 17 17:54:28 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 17 17:54:28 volumio setdatetime-helper.sh[5812]: Time is already synchronized. Jun 17 17:54:28 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 17 17:54:28 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 17 17:54:29 volumio volumio[1268]: info: CoreCommandRouter::volumioPause Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::pause Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::servicePause Jun 17 17:54:29 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:29 volumio volumio[1268]: info: CoreCommandRouter::servicePause Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:29 volumio volumio[1268]: info: ControllerMpd::pause Jun 17 17:54:29 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand pause Jun 17 17:54:29 volumio volumio[1268]: info: Jun 17 17:54:29 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:29 volumio volumio[1268]: info: sendMpdCommand pause took 2 milliseconds Jun 17 17:54:29 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:29 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:29 volumio volumio[1268]: info: sendMpdCommand status took 5 milliseconds Jun 17 17:54:29 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:29 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:29 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:29 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:29 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:29 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:29 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:29 volumio volumio[1268]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":2223,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"977 Kbps","isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:29 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::syncState stateService pause Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus pause Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:29 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:29 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:54:29 volumio volumio[1268]: info: ------------------------------ 9ms Jun 17 17:54:29 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:29 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:29 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:29 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 360 seconds. Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:30 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803291:11437669@11437669","service":"yandex_music","type":"song","name":"Надо же!","title":"Надо же!","album":"Две звезды","artist":"Алла Пугачёва","duration":230,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803291:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:30 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:30 volumio volumio[1268]: error: null Jun 17 17:54:30 volumio volumio[1268]: info: Jun 17 17:54:30 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:30 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:30 volumio volumio[1268]: info: sendMpdCommand status took 15 milliseconds Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:30 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:30 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:30 volumio volumio[1268]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":125000,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"977 Kbps","isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:30 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::syncState stateService pause Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus pause Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::stPlaybackTimer Jun 17 17:54:30 volumio volumio[1268]: info: ------------------------------ 30ms Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioPlay Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::play index undefined Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 17 17:54:30 volumio volumio[1268]: info: ControllerMpd::resume Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand play Jun 17 17:54:30 volumio volumio[1268]: info: Jun 17 17:54:30 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:30 volumio volumio[1268]: info: sendMpdCommand play took 6 milliseconds Jun 17 17:54:30 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:30 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:30 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:30 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:30 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:30 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125848,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"977 Kbps","isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:30 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus pause Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:30 volumio volumio[1268]: info: ------------------------------ 11ms Jun 17 17:54:30 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:30 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:30 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:30 volumio volumio[1268]: info: touch_display: Setting screensaver timeout to 0 seconds. Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:32 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803291:11437669@11437669","service":"yandex_music","type":"song","name":"Надо же!","title":"Надо же!","album":"Две звезды","artist":"Алла Пугачёва","duration":230,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803291:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:32 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:32 volumio volumio[1268]: error: null Jun 17 17:54:32 volumio volumio[1268]: info: Jun 17 17:54:32 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:32 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:32 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:32 volumio volumio[1268]: info: sendMpdCommand status took 2 milliseconds Jun 17 17:54:32 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:32 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:32 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 17 17:54:32 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:32 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:32 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":172000,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"977 Kbps","isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:32 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:54:32 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:32 volumio volumio[1268]: info: ------------------------------ 13ms Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioSeek Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::seek Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:32 volumio volumio[1268]: info: TRACKBLOCK {"id":"68803291:11437669@11437669","service":"yandex_music","type":"song","name":"Надо же!","title":"Надо же!","album":"Две звезды","artist":"Алла Пугачёва","duration":230,"albumart":"https://avatars.yandex.net/get-music-content/2386207/f52c4cdf.a.11437669-1/200x200","uri":"yandex_music/track/68803291:11437669@11437669","samplerate":"","bitdepth":"","trackType":"","codec":"flac-mp4","bitrate":0} Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::startPlaybackTimer Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:32 volumio volumio[1268]: info: ControllerMpd::seek Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:32 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:32 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:32 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:33 volumio volumio[1268]: error: null Jun 17 17:54:33 volumio volumio[1268]: info: Jun 17 17:54:33 volumio volumio[1268]: ---------------------------- MPD announces state update: player Jun 17 17:54:33 volumio volumio[1268]: info: ControllerMpd::getState Jun 17 17:54:33 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand status Jun 17 17:54:33 volumio volumio[1268]: info: sendMpdCommand status took 0 milliseconds Jun 17 17:54:33 volumio volumio[1268]: verbose: ControllerMpd::parseState Jun 17 17:54:33 volumio volumio[1268]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 17 17:54:33 volumio volumio[1268]: info: sendMpdCommand playlistinfo took 1 milliseconds Jun 17 17:54:33 volumio volumio[1268]: verbose: ControllerMpd::parseTrackInfo Jun 17 17:54:33 volumio volumio[1268]: info: ControllerMpd::pushState Jun 17 17:54:33 volumio volumio[1268]: info: CoreCommandRouter::servicePushState Jun 17 17:54:33 volumio volumio[1268]: info: CorePlayQueue::getTrack 0 Jun 17 17:54:33 volumio volumio[1268]: verbose: STATE SERVICE {"status":"play","position":0,"seek":178000,"duration":230,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"977 Kbps","isStreaming":false,"title":"Надо же!","artist":"Алла Пугачёва","album":"Две звезды","uri":"http://localhost:6601/?codec=flac-mp4&transport=raw&key=&url=https%3A%2F%2Fstrm-m9-92.strm.yandex.net%2Fmusic-v2%2Fraw%2Fysign1%3Dacdfca8b15c8936fd78fa1877360538ce7cf36ad51101f12485287d9a643d1a2%2Clid%3D1512%2Cpfx%2Csecret_version%3Dver-1%2Csfx%2Csource%3Dmds%2Cts%3D685f29e8%2F0%2F1465606%2F8d314a90.103479593.21.68803291%2Fflac-mp4&ext=.flac","trackType":"flac"} Jun 17 17:54:33 volumio volumio[1268]: verbose: CURRENT POSITION 0 Jun 17 17:54:33 volumio volumio[1268]: info: CoreStateMachine::syncState stateService play Jun 17 17:54:33 volumio volumio[1268]: info: CoreStateMachine::syncState currentStatus play Jun 17 17:54:33 volumio volumio[1268]: info: Received an update from plugin. extracting info from payload Jun 17 17:54:33 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:33 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 17 17:54:33 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:33 volumio volumio[1268]: info: CoreStateMachine::pushState Jun 17 17:54:33 volumio volumio[1268]: info: CoreCommandRouter::volumioPushState Jun 17 17:54:33 volumio volumio[1268]: info: ------------------------------ 4ms Jun 17 17:54:33 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:33 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:33 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:33 volumio volumio[1268]: info: CoreCommandRouter::volumioGetQueue Jun 17 17:54:33 volumio volumio[1268]: info: CoreStateMachine::getQueue Jun 17 17:54:33 volumio volumio[1268]: info: CorePlayQueue::getQueue Jun 17 17:54:41 volumio volumio[1268]: Searching all installed plugins Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Jun 17 17:54:41 volumio volumio[1268]: info: [youtube2] InnertubeLoader: creating Innertube instance... Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jun 17 17:54:41 volumio volumio[1268]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Jun 17 17:54:41 volumio volumio[1268]: info: CoreCommandRouter::executeOnPlugin: yandex_music , search Jun 17 17:54:42 volumio volumio[1268]: Use XMLElement.setAttribute instead Jun 17 17:54:42 volumio volumio[1268]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 17:54:42 volumio volumio[1268]: TypeError: children[i].attr(...).value is not a function Jun 17 17:54:42 volumio volumio[1268]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 17 17:54:42 volumio volumio[1268]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 17 17:54:42 volumio volumio[1268]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 17 17:54:42 volumio sudo[5851]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-17 17:53' Jun 17 17:54:42 volumio sudo[5851]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="cee9bb5b0ee50e4898478097a64b5c6c77d5a212" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Jun 14 07:24:14 UTC 2025" VOLUMIO_VERSION="4.012" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b365b054264e3ebc2709665da2b5d1ee"