-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-11-22 17:52:59 CET. -- Nov 22 17:51:00 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 22 17:51:00 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 22 17:51:00 volumio volumio[1107]: info: Discovery: Getting this device information Nov 22 17:51:00 volumio volumio[1107]: info: CoreCommandRouter::volumioGetState Nov 22 17:51:00 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 22 17:51:30 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 22 17:51:30 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 22 17:51:30 volumio volumio[1107]: info: Discovery: Getting this device information Nov 22 17:51:30 volumio volumio[1107]: info: CoreCommandRouter::volumioGetState Nov 22 17:51:30 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 22 17:51:56 volumio volumio[1107]: info: VolumeController::SetAlsaVolume1 Nov 22 17:51:56 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:51:56 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:51:56 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:51:57 volumio volumio[1107]: info: VolumeController::SetAlsaVolume55 Nov 22 17:51:57 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:51:57 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:51:57 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:51:58 volumio volumio[1107]: info: VolumeController::SetAlsaVolume68 Nov 22 17:51:58 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:51:58 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:51:58 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:00 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 22 17:52:00 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 22 17:52:00 volumio volumio[1107]: info: Discovery: Getting this device information Nov 22 17:52:00 volumio volumio[1107]: info: CoreCommandRouter::volumioGetState Nov 22 17:52:00 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 22 17:52:06 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::serviceStop Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Nov 22 17:52:06 volumio volumio[1107]: info: [1732294326285] ControllerWebradio::stop Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Nov 22 17:52:06 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:06 volumio volumio[1107]: info: Adding Item to queue: https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3 Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::play index 0 Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::play index undefined Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: [1732294326295] ControllerWebradio::clearAddPlayTrack Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:06 volumio volumio[1107]: info: Nov 22 17:52:06 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:06 volumio volumio[1107]: info: sendMpdCommand stop took 13 milliseconds Nov 22 17:52:06 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:06 volumio volumio[1107]: info: sendMpdCommand stop took 3 milliseconds Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Nov 22 17:52:06 volumio volumio[1107]: info: Nov 22 17:52:06 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:06 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:06 volumio volumio[1107]: info: Nov 22 17:52:06 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:06 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:06 volumio volumio[1107]: info: Nov 22 17:52:06 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:06 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:06 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:06 volumio volumio[1107]: info: sendMpdCommand clear took 3 milliseconds Nov 22 17:52:06 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:06 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand load "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:06 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:06 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:06 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:06 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:06 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:06 volumio volumio[1107]: info: ------------------------------ 13ms Nov 22 17:52:06 volumio volumio[1107]: info: ------------------------------ 11ms Nov 22 17:52:06 volumio volumio[1107]: info: Nov 22 17:52:06 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:06 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:06 volumio volumio[1107]: info: Nov 22 17:52:06 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:06 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:06 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:06 volumio volumio[1107]: info: ------------------------------ 14ms Nov 22 17:52:06 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 22 17:52:06 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:06 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 22 17:52:06 volumio volumio[1107]: info: ------------------------------ 21ms Nov 22 17:52:09 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" Nov 22 17:52:09 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:09 volumio volumio[1107]: info: Nov 22 17:52:09 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:09 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:09 volumio volumio[1107]: info: ------------------------------ 3383ms Nov 22 17:52:09 volumio volumio[1107]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 2 milliseconds Nov 22 17:52:09 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 17:52:09 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Nov 22 17:52:09 volumio volumio[1107]: Upnp client error: Error: This socket has been ended by the other party Nov 22 17:52:09 volumio volumio[1107]: info: Nov 22 17:52:09 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:09 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:09 volumio volumio[1107]: info: Nov 22 17:52:09 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:09 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:09 volumio volumio[1107]: info: ------------------------------ 11ms Nov 22 17:52:09 volumio volumio[1107]: info: sendMpdCommand play took 10 milliseconds Nov 22 17:52:09 volumio volumio[1107]: info: ------------------------------ 7ms Nov 22 17:52:09 volumio volumio[1107]: info: ------------------------------ 6ms Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 23 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 26 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 26 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 34ms Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: 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":"mp3","artist":null,"album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 75ms Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 75ms Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 55ms Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 54ms Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 53ms Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:10 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:10 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:10 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:10 volumio volumio[1107]: info: Nov 22 17:52:10 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 10ms Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 9 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:10 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:10 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"RIHANNA - UMBRELLA","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"RIHANNA - UMBRELLA","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:10 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:10 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"RIHANNA - UMBRELLA","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:10 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:10 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:10 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 30ms Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:10 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:12 volumio volumio[1107]: info: Nov 22 17:52:12 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:12 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:12 volumio volumio[1107]: info: Nov 22 17:52:12 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:12 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:12 volumio volumio[1107]: info: Nov 22 17:52:12 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:12 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:12 volumio volumio[1107]: info: Nov 22 17:52:12 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:12 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:12 volumio volumio[1107]: info: Nov 22 17:52:12 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:12 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:12 volumio volumio[1107]: info: Nov 22 17:52:12 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:12 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:12 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:12 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:12 volumio volumio[1107]: info: ------------------------------ 4ms Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:12 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:12 volumio volumio[1107]: info: ------------------------------ 4ms Nov 22 17:52:12 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:12 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:12 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:12 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:12 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"RIHANNA - UMBRELLA","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:12 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:12 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:12 volumio volumio[1107]: info: ------------------------------ 18ms Nov 22 17:52:12 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 22 17:52:12 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:12 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:12 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:12 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:12 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"RIHANNA - UMBRELLA","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:12 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:12 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:12 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:12 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:12 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"RIHANNA - UMBRELLA","artist":"Absolut AI","album":null,"uri":"https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3","trackType":""} Nov 22 17:52:12 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:12 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:12 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:12 volumio volumio[1107]: info: ------------------------------ 31ms Nov 22 17:52:12 volumio volumio[1107]: info: ------------------------------ 30ms Nov 22 17:52:15 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::serviceStop Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Nov 22 17:52:15 volumio volumio[1107]: info: [1732294335163] ControllerWebradio::stop Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Nov 22 17:52:15 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:15 volumio volumio[1107]: info: Adding Item to queue: http://stream-dc1.radioparadise.com/rp_192m.ogg Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::play index 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::play index undefined Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: [1732294335173] ControllerWebradio::clearAddPlayTrack Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand stop took 13 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand stop took 4 milliseconds Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand clear took 4 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand load "http://stream-dc1.radioparadise.com/rp_192m.ogg" Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 13ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 12ms Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 14ms Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 20ms Nov 22 17:52:15 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:15 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "http://stream-dc1.radioparadise.com/rp_192m.ogg" Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 285ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 284ms Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand add "http://stream-dc1.radioparadise.com/rp_192m.ogg" took 3 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 6ms Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand play took 5 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 4ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 24 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 28 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 6 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rp_192m.ogg","artist":null,"album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 35ms Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:15 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:15 volumio volumio[1107]: info: Nov 22 17:52:15 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 14 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 9ms Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 8 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 7ms Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 65ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 66ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 46ms Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 32 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 36ms Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand status took 33 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 32 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 32 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 31 milliseconds Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286751,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 70ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 70ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 65ms Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 33 milliseconds Nov 22 17:52:15 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 33 milliseconds Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286945,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:15 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:15 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":287048,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"All Them Witches - The Marriage of Coyote Woman","artist":"Radio Paradise (192k Ogg/Vorbis) - playlist: radioparadise.com","album":null,"uri":"http://stream-dc1.radioparadise.com/rp_192m.ogg","trackType":"ogg"} Nov 22 17:52:15 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:15 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:15 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 88ms Nov 22 17:52:15 volumio volumio[1107]: info: ------------------------------ 86ms Nov 22 17:52:17 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::serviceStop Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Nov 22 17:52:17 volumio volumio[1107]: info: [1732294337463] ControllerWebradio::stop Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Nov 22 17:52:17 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:17 volumio volumio[1107]: info: Adding Item to queue: http://stream.radioparadise.com/flacm Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::play index 0 Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::play index undefined Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: [1732294337473] ControllerWebradio::clearAddPlayTrack Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:17 volumio volumio[1107]: info: Nov 22 17:52:17 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:17 volumio volumio[1107]: info: sendMpdCommand stop took 12 milliseconds Nov 22 17:52:17 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:17 volumio volumio[1107]: info: sendMpdCommand stop took 3 milliseconds Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Nov 22 17:52:17 volumio volumio[1107]: info: Nov 22 17:52:17 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:17 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:17 volumio volumio[1107]: info: Nov 22 17:52:17 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:17 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:17 volumio volumio[1107]: info: Nov 22 17:52:17 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:17 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:17 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:17 volumio volumio[1107]: info: sendMpdCommand clear took 4 milliseconds Nov 22 17:52:17 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:17 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/flacm" Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:17 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:17 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:17 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:17 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:17 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:17 volumio volumio[1107]: info: ------------------------------ 16ms Nov 22 17:52:17 volumio volumio[1107]: info: ------------------------------ 16ms Nov 22 17:52:17 volumio volumio[1107]: info: Nov 22 17:52:17 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:17 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:17 volumio volumio[1107]: info: Nov 22 17:52:17 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:17 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:17 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:17 volumio volumio[1107]: info: ------------------------------ 18ms Nov 22 17:52:17 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 17 milliseconds Nov 22 17:52:17 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:17 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 22 17:52:17 volumio volumio[1107]: info: ------------------------------ 23ms Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/flacm" Nov 22 17:52:18 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:18 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 974ms Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 973ms Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand add "http://stream.radioparadise.com/flacm" took 2 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:18 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:18 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand play took 5 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 4ms Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 21 milliseconds Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 22 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 47ms Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 46ms Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 19 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 19 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 19 milliseconds Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 41ms Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 38ms Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 38ms Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:18 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:18 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:18 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:18 volumio volumio[1107]: info: Nov 22 17:52:18 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 8ms Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 7 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 7ms Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 11 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 10ms Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand status took 10 milliseconds Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:18 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flacm","artist":"Radio Paradise (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/flacm","trackType":"com/flacm"} Nov 22 17:52:18 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:18 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:18 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 35ms Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 34ms Nov 22 17:52:18 volumio volumio[1107]: info: ------------------------------ 34ms Nov 22 17:52:20 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::serviceStop Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Nov 22 17:52:20 volumio volumio[1107]: info: [1732294340968] ControllerWebradio::stop Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Nov 22 17:52:20 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:20 volumio volumio[1107]: info: Adding Item to queue: http://stream.radioparadise.com/mellow-flacm Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::play index 0 Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::play index undefined Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: [1732294340978] ControllerWebradio::clearAddPlayTrack Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:20 volumio volumio[1107]: info: Nov 22 17:52:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:20 volumio volumio[1107]: info: sendMpdCommand stop took 15 milliseconds Nov 22 17:52:20 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:20 volumio volumio[1107]: info: sendMpdCommand stop took 6 milliseconds Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Nov 22 17:52:20 volumio volumio[1107]: info: Nov 22 17:52:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:20 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:20 volumio volumio[1107]: info: Nov 22 17:52:20 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:20 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:20 volumio volumio[1107]: info: Nov 22 17:52:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:20 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:20 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:20 volumio volumio[1107]: info: sendMpdCommand clear took 3 milliseconds Nov 22 17:52:20 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:20 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/mellow-flacm" Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:20 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:20 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:20 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:20 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:20 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:20 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:20 volumio volumio[1107]: info: ------------------------------ 12ms Nov 22 17:52:20 volumio volumio[1107]: info: ------------------------------ 12ms Nov 22 17:52:20 volumio volumio[1107]: info: Nov 22 17:52:20 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:20 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:21 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 13ms Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 19ms Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/mellow-flacm" Nov 22 17:52:21 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:21 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:21 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 44ms Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 43ms Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand add "http://stream.radioparadise.com/mellow-flacm" took 1 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:21 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:21 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand play took 4 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 23 milliseconds Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 24 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 23 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 52ms Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 53ms Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:21 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 26 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 27 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 28 milliseconds Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 55ms Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 52ms Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 52ms Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:21 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:21 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:21 volumio volumio[1107]: info: Nov 22 17:52:21 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 40ms Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 37 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 4ms Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:21 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:21 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:21 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 65ms Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 31ms Nov 22 17:52:21 volumio volumio[1107]: info: ------------------------------ 29ms Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 22 17:52:21 volumio volumio[1107]: info: Discovery: Getting this device information Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::volumioGetState Nov 22 17:52:21 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 22 17:52:24 volumio volumio[1107]: info: Nov 22 17:52:24 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:24 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:24 volumio volumio[1107]: info: Nov 22 17:52:24 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:24 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:24 volumio volumio[1107]: info: Nov 22 17:52:24 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:24 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:24 volumio volumio[1107]: info: Nov 22 17:52:24 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:24 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:24 volumio volumio[1107]: info: Nov 22 17:52:24 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:24 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:24 volumio volumio[1107]: info: Nov 22 17:52:24 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:24 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:24 volumio volumio[1107]: info: ------------------------------ 7ms Nov 22 17:52:24 volumio volumio[1107]: info: sendMpdCommand status took 6 milliseconds Nov 22 17:52:24 volumio volumio[1107]: info: ------------------------------ 6ms Nov 22 17:52:24 volumio volumio[1107]: info: sendMpdCommand status took 6 milliseconds Nov 22 17:52:24 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:24 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:24 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:24 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 22 17:52:24 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:24 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:24 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:24 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:24 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3775,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Gregory Alan Isakov - That Moon Song","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:24 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:24 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:24 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:24 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:24 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3775,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Gregory Alan Isakov - That Moon Song","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:24 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:24 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:24 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:24 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:24 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3775,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Gregory Alan Isakov - That Moon Song","artist":"Radio Paradise Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Nov 22 17:52:24 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:24 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:24 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:24 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:24 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:24 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:30 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 22 17:52:30 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 22 17:52:30 volumio volumio[1107]: info: Discovery: Getting this device information Nov 22 17:52:30 volumio volumio[1107]: info: CoreCommandRouter::volumioGetState Nov 22 17:52:30 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 22 17:52:33 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::serviceStop Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Nov 22 17:52:33 volumio volumio[1107]: info: [1732294353893] ControllerWebradio::stop Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Nov 22 17:52:33 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:33 volumio volumio[1107]: info: Adding Item to queue: http://stream.radioparadise.com/rock-flacm Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::play index 0 Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::play index undefined Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: [1732294353903] ControllerWebradio::clearAddPlayTrack Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand stop took 15 milliseconds Nov 22 17:52:33 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand stop took 5 milliseconds Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:33 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:33 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:33 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand clear took 4 milliseconds Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/rock-flacm" Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:33 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 10ms Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:33 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:33 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand status took 12 milliseconds Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 12ms Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:33 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:33 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:33 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:33 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 23ms Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 27ms Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:33 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:33 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:33 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/rock-flacm" Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 40ms Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 27ms Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:33 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand add "http://stream.radioparadise.com/rock-flacm" took 3 milliseconds Nov 22 17:52:33 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 17:52:33 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:33 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:33 volumio volumio[1107]: info: Nov 22 17:52:33 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:33 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:33 volumio volumio[1107]: info: sendMpdCommand play took 4 milliseconds Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:33 volumio volumio[1107]: info: ------------------------------ 2ms Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 23 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 26 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 26 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 6 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 34ms Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 6 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 43ms Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 14 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 11 milliseconds Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 77ms Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 58ms Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 57ms Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 57ms Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:34 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:34 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:34 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:34 volumio volumio[1107]: info: Nov 22 17:52:34 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 18ms Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 18 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 17ms Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 16 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 15ms Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand status took 16 milliseconds Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 22 17:52:34 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"rock-flacm","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:34 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:34 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:34 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 52ms Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 51ms Nov 22 17:52:34 volumio volumio[1107]: info: ------------------------------ 51ms Nov 22 17:52:35 volumio volumio[1107]: info: Nov 22 17:52:35 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:35 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:35 volumio volumio[1107]: info: Nov 22 17:52:35 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:35 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:35 volumio volumio[1107]: info: Nov 22 17:52:35 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:35 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:35 volumio volumio[1107]: info: Nov 22 17:52:35 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:35 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:35 volumio volumio[1107]: info: Nov 22 17:52:35 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:35 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:35 volumio volumio[1107]: info: Nov 22 17:52:35 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:35 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:35 volumio volumio[1107]: info: ------------------------------ 9ms Nov 22 17:52:35 volumio volumio[1107]: info: sendMpdCommand status took 7 milliseconds Nov 22 17:52:35 volumio volumio[1107]: info: ------------------------------ 7ms Nov 22 17:52:35 volumio volumio[1107]: info: sendMpdCommand status took 6 milliseconds Nov 22 17:52:35 volumio volumio[1107]: info: ------------------------------ 6ms Nov 22 17:52:35 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:35 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:35 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:35 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:35 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:35 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:35 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2173,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Gomez - Ping One Down","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:35 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:35 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:35 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:35 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:35 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2173,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Gomez - Ping One Down","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:35 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:35 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:35 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:35 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:35 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2173,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Gomez - Ping One Down","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 22 17:52:35 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:35 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:35 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:35 volumio volumio[1107]: info: ------------------------------ 32ms Nov 22 17:52:35 volumio volumio[1107]: info: ------------------------------ 31ms Nov 22 17:52:35 volumio volumio[1107]: info: ------------------------------ 32ms Nov 22 17:52:37 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::ClearQueue Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::stPlaybackTimer Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::serviceStop Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::serviceStop Nov 22 17:52:37 volumio volumio[1107]: info: [1732294357293] ControllerWebradio::stop Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::clearPlayQueue Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::addQueueItems Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::addQueueItems Nov 22 17:52:37 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:37 volumio volumio[1107]: info: Adding Item to queue: http://stream.radioparadise.com/world-etc-flacm Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushQueue Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::saveQueue Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::updateTrackBlock Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrackBlock Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPlay Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::play index 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::stop Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::play index undefined Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::startPlaybackTimer Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: [1732294357301] ControllerWebradio::clearAddPlayTrack Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand stop Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand stop took 11 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand stop took 4 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand clear Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand clear took 3 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/world-etc-flacm" Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 16ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 15ms Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 17ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 15 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 22ms Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" Nov 22 17:52:37 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:37 volumio volumio[1107]: error: updateQueue error: null Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 33ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 32ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" took 1 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand play Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand play took 4 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 4ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 5 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus stop Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 19ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 22ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 22ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 17 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 16 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 15 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 40ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 37ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 22 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 50ms Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:37 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:37 volumio volumio[1107]: info: Nov 22 17:52:37 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 7ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 6 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 4ms Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:37 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"world-etc-flacm","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:37 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:37 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:37 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 29ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 29ms Nov 22 17:52:37 volumio volumio[1107]: info: ------------------------------ 28ms Nov 22 17:52:40 volumio volumio[1107]: info: Nov 22 17:52:40 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:40 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:40 volumio volumio[1107]: info: Nov 22 17:52:40 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:40 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:40 volumio volumio[1107]: info: Nov 22 17:52:40 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:40 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:40 volumio volumio[1107]: info: Nov 22 17:52:40 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:40 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:40 volumio volumio[1107]: info: Nov 22 17:52:40 volumio volumio[1107]: ---------------------------- MPD announces system playlist update Nov 22 17:52:40 volumio volumio[1107]: info: Ignoring MPD Status Update Nov 22 17:52:40 volumio volumio[1107]: info: Nov 22 17:52:40 volumio volumio[1107]: ---------------------------- MPD announces state update: player Nov 22 17:52:40 volumio volumio[1107]: info: ControllerMpd::getState Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand status Nov 22 17:52:40 volumio volumio[1107]: info: ------------------------------ 5ms Nov 22 17:52:40 volumio volumio[1107]: info: sendMpdCommand status took 4 milliseconds Nov 22 17:52:40 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:40 volumio volumio[1107]: info: sendMpdCommand status took 3 milliseconds Nov 22 17:52:40 volumio volumio[1107]: info: ------------------------------ 3ms Nov 22 17:52:40 volumio volumio[1107]: info: sendMpdCommand status took 2 milliseconds Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::parseState Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 22 17:52:40 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:40 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:40 volumio volumio[1107]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:40 volumio volumio[1107]: verbose: ControllerMpd::parseTrackInfo Nov 22 17:52:40 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:40 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:40 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Marijata - I Walk Alone","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:40 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:40 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:40 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:40 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:40 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Marijata - I Walk Alone","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:40 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:40 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:40 volumio volumio[1107]: info: ControllerMpd::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::servicePushState Nov 22 17:52:40 volumio volumio[1107]: info: CorePlayQueue::getTrack 0 Nov 22 17:52:40 volumio volumio[1107]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3454,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Marijata - I Walk Alone","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 22 17:52:40 volumio volumio[1107]: verbose: CURRENT POSITION 0 Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::syncState stateService play Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::syncState currentStatus play Nov 22 17:52:40 volumio volumio[1107]: info: Received an update from plugin. extracting info from payload Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreStateMachine::pushState Nov 22 17:52:40 volumio volumio[1107]: info: CoreCommandRouter::volumioPushState Nov 22 17:52:40 volumio volumio[1107]: info: ------------------------------ 27ms Nov 22 17:52:40 volumio volumio[1107]: info: ------------------------------ 25ms Nov 22 17:52:40 volumio volumio[1107]: info: ------------------------------ 25ms Nov 22 17:52:47 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 22 17:52:47 volumio volumio[1107]: info: CURURI: playlists Nov 22 17:52:47 volumio volumio[1107]: info: Listing playlists Nov 22 17:52:47 volumio volumio[1107]: info: Preload queue cleared Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 22 17:52:55 volumio volumio[1107]: info: Retrieving Cloud Streaming UI Nov 22 17:52:55 volumio volumio[1107]: info: Getting Tidal Cloud Configuration Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 22 17:52:55 volumio volumio[1107]: info: Getting Qobuz Cloud Configuration Nov 22 17:52:55 volumio volumio[1107]: info: Asking plugin for UI Config Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 22 17:52:55 volumio volumio[1107]: info: Getting Spotify Cloud Configuration Nov 22 17:52:55 volumio volumio[1107]: info: Asking plugin for UI Config Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 22 17:52:55 volumio volumio[1107]: info: Saving Spotify Acccount Nov 22 17:52:55 volumio volumio[1107]: info: Got Tidal Cloud Configuration Nov 22 17:52:55 volumio volumio[1107]: info: Got it Nov 22 17:52:55 volumio volumio[1107]: info: Got it Nov 22 17:52:55 volumio volumio[1107]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 22 17:52:55 volumio volumio[1107]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::volumioGetBrowseSources Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::volumioGetBrowseSources Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::volumioGetBrowseSources Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 22 17:52:55 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 22 17:52:58 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 22 17:52:58 volumio volumio[1107]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 22 17:52:58 volumio volumio[1107]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 22 17:52:58 volumio volumio[1107]: Error: getaddrinfo -3007 Nov 22 17:52:58 volumio volumio[1107]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Nov 22 17:52:58 volumio volumio[1107]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Nov 22 17:52:58 volumio volumio[1107]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Nov 22 17:52:58 volumio volumio[1107]: code: -3007, Nov 22 17:52:58 volumio volumio[1107]: errno: -3007, Nov 22 17:52:58 volumio volumio[1107]: syscall: 'getaddrinfo' Nov 22 17:52:58 volumio volumio[1107]: } Nov 22 17:52:58 volumio volumio[1107]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 22 17:52:59 volumio sudo[15307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-22 17:51 Nov 22 17:52:59 volumio sudo[15307]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"