Feb 17 11:07:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 17 11:07:00 volumio-rpi4 volumio[1523]: info: Updating MyVolumio device info Feb 17 11:07:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:07:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:07:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:07:00 volumio-rpi4 volumio[1523]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Feb 17 11:07:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetState Feb 17 11:07:00 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:00 volumio-rpi4 volumio[1523]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Feb 17 11:07:02 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:04 volumio-rpi4 kernel: vc4-drm gpu: [drm] User-defined mode not supported: "720x480": 60 27000 720 736 798 858 480 489 495 525 0x68 0xa Feb 17 11:07:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:07:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:07:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Feb 17 11:07:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Feb 17 11:07:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Feb 17 11:07:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetBrowseSources Feb 17 11:07:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 17 11:07:06 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:08 volumio-rpi4 volumio[1523]: error: MyVolumio Plugin failed to authenticate in a timely fashion Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: Completed starting MyVolumio Plugin Feb 17 11:07:08 volumio-rpi4 volumio[1523]: [Metrics] CommandRouter: 67s 39.91ms Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumiosetStartupVolume Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::Close All Modals sent Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::Close All Modals sent Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: VolumeController::SetAlsaVolume33 Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: Cannot play startup sound: Error: Command failed: /usr/bin/aplay -D volumio /volumio/app/startup.wav Feb 17 11:07:08 volumio-rpi4 volumio[1523]: aplay: main:831: audio open error: Unknown error 524 Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: VolumeController::SetAlsaVolume28 Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:08 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:09 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Feb 17 11:07:09 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 17 11:07:09 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Feb 17 11:07:10 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: Received Get System Version Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: Received Get System Info Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: Discovery: Getting this device information Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetState Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:11 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 17 11:07:12 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetVisibleSources Feb 17 11:07:12 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:07:12 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetQueue Feb 17 11:07:12 volumio-rpi4 volumio[1523]: info: CoreStateMachine::getQueue Feb 17 11:07:12 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getQueue Feb 17 11:07:14 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 17 11:07:14 volumio-rpi4 volumio[1523]: info: Preload queue cleared Feb 17 11:07:14 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:15 volumio-rpi4 volumio[1523]: info: BOOT COMPLETED Feb 17 11:07:16 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 17 11:07:16 volumio-rpi4 volumio[1523]: info: Preload queue cleared Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: Preload queue cleared Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreStateMachine::ClearQueue Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stop Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CorePlayQueue::clearPlayQueue Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CorePlayQueue::saveQueue Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushQueue Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreStateMachine::addQueueItems Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CorePlayQueue::addQueueItems Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: Preload queue cleared Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s309381 Feb 17 11:07:18 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushQueue Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CorePlayQueue::saveQueue Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::updateTrackBlock Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrackBlock Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPlay Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::play index 0 Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stop Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::play index undefined Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CoreStateMachine::startPlaybackTimer Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: [1771322839827] ControllerWebradio::clearAddPlayTrack Feb 17 11:07:19 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: sendMpdCommand stop took 22 milliseconds Feb 17 11:07:19 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:19 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: sendMpdCommand clear took 16 milliseconds Feb 17 11:07:19 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand load "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:19 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:19 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:19 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:19 volumio-rpi4 volumio[1523]: info: ------------------------------ 30ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:20 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand add "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 266ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 260ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand add "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" took 14 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand play Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 37ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand play took 24 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 17ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 14ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Preload queue cleared Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::ClearQueue Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stop Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::clearPlayQueue Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::saveQueue Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushQueue Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::addQueueItems Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::addQueueItems Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Preload queue cleared Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s309381 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushQueue Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::saveQueue Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::updateTrackBlock Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrackBlock Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPlay Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::play index 0 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stop Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::play index undefined Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::startPlaybackTimer Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: [1771322840323] ControllerWebradio::clearAddPlayTrack Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand stop took 27 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 26 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand clear took 28 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 21 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 23 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand load "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 145ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 148ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 148ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 134 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:20 volumio-rpi4 volumio[1523]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 199ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:20 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand add "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 72ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 71ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand add "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" took 11 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 11:07:20 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand play Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:20 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 19ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: sendMpdCommand play took 14 milliseconds Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 12ms Feb 17 11:07:20 volumio-rpi4 volumio[1523]: info: ------------------------------ 10ms Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 32 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 32 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:21 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 84 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 83 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 82 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 84 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 86 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 85 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ------------------------------ 88ms Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 66 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ------------------------------ 65ms Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 49 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ------------------------------ 49ms Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus stop Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ------------------------------ 208ms Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ------------------------------ 269ms Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 179 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ------------------------------ 182ms Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 164 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 149 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 150 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 144 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 144 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 142 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 143 milliseconds Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:21 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:21 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 963ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 948ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 930ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 948ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 948ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 916ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 946 milliseconds Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 952 milliseconds Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 1348ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ------------------------------ 1354ms Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioStop Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stop Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stPlaybackTimer Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::updateTrackBlock Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrackBlock Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreStateMachine::serviceStop Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::serviceStop Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: [1771322842662] ControllerWebradio::stop Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:22 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: sendMpdCommand stop took 67 milliseconds Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:22 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:22 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:22 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:22 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 283 milliseconds Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 39 milliseconds Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 15 milliseconds Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 48 milliseconds Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 48 milliseconds Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 49 milliseconds Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:23 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: ------------------------------ 566ms Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: ------------------------------ 321ms Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: ------------------------------ 321ms Feb 17 11:07:23 volumio-rpi4 volumio[1523]: info: touch_display: Setting screensaver timeout to 180 seconds. Feb 17 11:07:26 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:30 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPlay Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: CoreStateMachine::play index undefined Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: CoreStateMachine::startPlaybackTimer Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: [1771322852874] ControllerWebradio::clearAddPlayTrack Feb 17 11:07:32 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: sendMpdCommand stop took 0 milliseconds Feb 17 11:07:32 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:32 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: sendMpdCommand clear took 25 milliseconds Feb 17 11:07:32 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand load "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:32 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:32 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:32 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:32 volumio-rpi4 volumio[1523]: info: ------------------------------ 21ms Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand add "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" Feb 17 11:07:33 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:33 volumio-rpi4 volumio[1523]: error: updateQueue error: null Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ------------------------------ 690ms Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ------------------------------ 690ms Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand add "http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com" took 6 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand play Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ------------------------------ 21ms Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand play took 21 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ------------------------------ 7ms Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ------------------------------ 2ms Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 4 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 4 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 3 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:33 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 82 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 81 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 59 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 60 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 31 milliseconds Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus stop Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:33 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:33 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 237ms Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 446ms Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 446ms Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:34 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:34 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:34 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces system playlist update Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Ignoring MPD Status Update Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:34 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 385 milliseconds Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 384ms Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 383 milliseconds Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 384ms Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 383 milliseconds Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 382 milliseconds Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 380 milliseconds Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 22ms Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 4 milliseconds Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:34 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 811ms Feb 17 11:07:34 volumio-rpi4 volumio[1523]: info: ------------------------------ 789ms Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ------------------------------ 752ms Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 751 milliseconds Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 748 milliseconds Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 748 milliseconds Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 748 milliseconds Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 748 milliseconds Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":881,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ------------------------------ 1822ms Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ------------------------------ 1817ms Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ------------------------------ 1822ms Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ------------------------------ 1468ms Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 678 milliseconds Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1282,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ANTENNE BAYERN - 70er Hits","artist":"ANTENNE BAYERN 70er Hits","album":null,"uri":"http://stream.antenne.de/70er-hits/stream/mp3?aw_0_1st.playerid=tunein.com","trackType":"com"} Feb 17 11:07:35 volumio-rpi4 volumio[1523]: verbose: CURRENT POSITION 0 Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState stateService play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::syncState currentStatus play Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: Received an update from plugin. extracting info from payload Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:35 volumio-rpi4 volumio[1523]: info: ------------------------------ 1722ms Feb 17 11:07:36 volumio-rpi4 volumio[1523]: info: touch_display: Setting screensaver timeout to 0 seconds. Feb 17 11:07:38 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioStop Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stop Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreStateMachine::stPlaybackTimer Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreStateMachine::updateTrackBlock Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrackBlock Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreStateMachine::serviceStop Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::serviceStop Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: [1771322859825] ControllerWebradio::stop Feb 17 11:07:39 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:39 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: sendMpdCommand stop took 120 milliseconds Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:39 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:39 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:39 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: Feb 17 11:07:39 volumio-rpi4 volumio[1523]: ---------------------------- MPD announces state update: player Feb 17 11:07:39 volumio-rpi4 volumio[1523]: info: ControllerMpd::getState Feb 17 11:07:39 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand status Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 70 milliseconds Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 69 milliseconds Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: sendMpdCommand status took 68 milliseconds Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:40 volumio-rpi4 volumio[1523]: verbose: ControllerMpd::parseTrackInfo Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: ControllerMpd::pushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::servicePushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreStateMachine::pushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioPushState Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getTrack 0 Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: ------------------------------ 337ms Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: ------------------------------ 301ms Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: ------------------------------ 301ms Feb 17 11:07:40 volumio-rpi4 volumio[1523]: info: touch_display: Setting screensaver timeout to 180 seconds. Feb 17 11:07:42 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:46 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:50 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:54 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:07:55 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetVisibleSources Feb 17 11:07:55 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 17 11:07:55 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetQueue Feb 17 11:07:56 volumio-rpi4 volumio[1523]: info: CoreStateMachine::getQueue Feb 17 11:07:56 volumio-rpi4 volumio[1523]: info: CorePlayQueue::getQueue Feb 17 11:07:56 volumio-rpi4 volumio[1523]: info: Listing playlists Feb 17 11:07:57 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Retrieving Cloud Streaming UI Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Getting Tidal Cloud Configuration Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Getting Qobuz Cloud Configuration Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Asking plugin for UI Config Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Getting Spotify Cloud Configuration Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Asking plugin for UI Config Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Saving Spotify Acccount Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Got Tidal Cloud Configuration Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Got it Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: Got it Feb 17 11:08:00 volumio-rpi4 volumio[1523]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 17 11:08:00 volumio-rpi4 volumio[1523]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetBrowseSources Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetBrowseSources Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::volumioGetBrowseSources Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:08:00 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Feb 17 11:08:04 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Feb 17 11:08:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Feb 17 11:08:05 volumio-rpi4 volumio[1523]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Feb 17 11:08:05 volumio-rpi4 volumio[1523]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 11:08:05 volumio-rpi4 volumio[1523]: Error: dns service error: unknown Feb 17 11:08:05 volumio-rpi4 volumio[1523]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Feb 17 11:08:05 volumio-rpi4 volumio[1523]: at MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Feb 17 11:08:05 volumio-rpi4 volumio[1523]: errorCode: -65537 Feb 17 11:08:05 volumio-rpi4 volumio[1523]: } Feb 17 11:08:05 volumio-rpi4 volumio[1523]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 11:08:07 volumio-rpi4 sudo[2576]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-17 11:07' Feb 17 11:08:07 volumio-rpi4 sudo[2576]: 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="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"