-- Logs begin at Wed 2024-10-02 14:49:02 UTC, end at Sat 2024-11-02 15:34:48 UTC. -- Nov 02 15:33:04 volumio volumio[797]: info: CoreCommandRouter::volumioGetState Nov 02 15:33:04 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:27 volumio volumio[797]: info: CoreCommandRouter::volumioGetState Nov 02 15:33:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:30 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 02 15:33:33 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 02 15:33:33 volumio volumio[797]: info: Getting webradio selection Nov 02 15:33:37 volumio volumio[797]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::ClearQueue Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:37 volumio volumio[797]: info: CorePlayQueue::clearPlayQueue Nov 02 15:33:37 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:37 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:37 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::addQueueItems Nov 02 15:33:37 volumio volumio[797]: info: CorePlayQueue::addQueueItems Nov 02 15:33:37 volumio volumio[797]: info: Adding Item to queue: https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3 Nov 02 15:33:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 02 15:33:37 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:37 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:33:37 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:33:37 volumio volumio[797]: info: CoreCommandRouter::volumioPlay Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::play index 0 Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::play index undefined Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:37 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:37 volumio volumio[797]: info: CoreStateMachine::startPlaybackTimer Nov 02 15:33:37 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:37 volumio volumio[797]: info: [1730561617130] ControllerWebradio::clearAddPlayTrack Nov 02 15:33:37 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:33:37 volumio volumio[797]: info: sendMpdCommand stop took 7 milliseconds Nov 02 15:33:37 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 15:33:37 volumio volumio[797]: info: Nov 02 15:33:37 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:37 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:37 volumio volumio[797]: info: sendMpdCommand clear took 4 milliseconds Nov 02 15:33:37 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Nov 02 15:33:37 volumio volumio[797]: info: Nov 02 15:33:37 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:37 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:37 volumio volumio[797]: error: updateQueue error: null Nov 02 15:33:37 volumio volumio[797]: info: ------------------------------ 14ms Nov 02 15:33:37 volumio volumio[797]: error: Upnp client error: Error: This socket has been ended by the other party Nov 02 15:33:38 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Nov 02 15:33:38 volumio volumio[797]: error: updateQueue error: null Nov 02 15:33:38 volumio volumio[797]: info: Nov 02 15:33:38 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:38 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:38 volumio volumio[797]: info: ------------------------------ 948ms Nov 02 15:33:38 volumio volumio[797]: info: sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" took 4 milliseconds Nov 02 15:33:38 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 15:33:38 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand play Nov 02 15:33:38 volumio volumio[797]: info: Nov 02 15:33:38 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:38 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:38 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:33:38 volumio volumio[797]: info: sendMpdCommand play took 6 milliseconds Nov 02 15:33:38 volumio volumio[797]: info: ------------------------------ 6ms Nov 02 15:33:39 volumio volumio[797]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::ClearQueue Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:39 volumio volumio[797]: info: CorePlayQueue::clearPlayQueue Nov 02 15:33:39 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:39 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:39 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::addQueueItems Nov 02 15:33:39 volumio volumio[797]: info: CorePlayQueue::addQueueItems Nov 02 15:33:39 volumio volumio[797]: info: Adding Item to queue: https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3 Nov 02 15:33:39 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 02 15:33:39 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:39 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:33:39 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:33:39 volumio volumio[797]: info: CoreCommandRouter::volumioPlay Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::play index 0 Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::play index undefined Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:39 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:39 volumio volumio[797]: info: CoreStateMachine::startPlaybackTimer Nov 02 15:33:39 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:39 volumio volumio[797]: info: [1730561619693] ControllerWebradio::clearAddPlayTrack Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:33:39 volumio volumio[797]: info: Nov 02 15:33:39 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:39 volumio volumio[797]: info: sendMpdCommand stop took 8 milliseconds Nov 02 15:33:39 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 15:33:39 volumio volumio[797]: info: Nov 02 15:33:39 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:39 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:39 volumio volumio[797]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:33:39 volumio volumio[797]: info: sendMpdCommand clear took 9 milliseconds Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Nov 02 15:33:39 volumio volumio[797]: info: Nov 02 15:33:39 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:39 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:39 volumio volumio[797]: error: updateQueue error: null Nov 02 15:33:39 volumio volumio[797]: info: ------------------------------ 23ms Nov 02 15:33:39 volumio volumio[797]: info: sendMpdCommand playlistinfo took 15 milliseconds Nov 02 15:33:39 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:39 volumio volumio[797]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 15:33:39 volumio volumio[797]: info: ------------------------------ 42ms Nov 02 15:33:40 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Nov 02 15:33:40 volumio volumio[797]: info: sendMpdCommand status took 751 milliseconds Nov 02 15:33:40 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:40 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:40 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:40 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:40 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:40 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:40 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:40 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:40 volumio volumio[797]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 02 15:33:40 volumio volumio[797]: info: ------------------------------ 775ms Nov 02 15:33:40 volumio volumio[797]: info: Nov 02 15:33:40 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:40 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:40 volumio volumio[797]: info: Nov 02 15:33:40 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:40 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:40 volumio volumio[797]: info: sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" took 38 milliseconds Nov 02 15:33:40 volumio volumio[797]: info: ------------------------------ 17ms Nov 02 15:33:40 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 15:33:40 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand play Nov 02 15:33:40 volumio volumio[797]: info: Nov 02 15:33:40 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:40 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:40 volumio volumio[797]: info: ------------------------------ 21ms Nov 02 15:33:40 volumio volumio[797]: info: sendMpdCommand play took 9 milliseconds Nov 02 15:33:40 volumio volumio[797]: info: ------------------------------ 7ms Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: 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://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: 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://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:43 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 64ms Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 63ms Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 38 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 35 milliseconds Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: 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://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:43 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: 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://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:43 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 90ms Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 83ms Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:43 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:43 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:43 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 12ms Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 11 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 11ms Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:43 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:43 volumio volumio[797]: info: Nov 02 15:33:43 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 16ms Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 13 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:43 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:43 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 62ms Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 60ms Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 37 milliseconds Nov 02 15:33:43 volumio volumio[797]: info: sendMpdCommand playlistinfo took 36 milliseconds Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:43 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:43 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:43 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:43 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:43 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:43 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 88ms Nov 02 15:33:43 volumio volumio[797]: info: ------------------------------ 79ms Nov 02 15:33:44 volumio volumio[797]: info: Nov 02 15:33:44 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:44 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:44 volumio volumio[797]: info: Nov 02 15:33:44 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:44 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:44 volumio volumio[797]: info: Nov 02 15:33:44 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:44 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:44 volumio volumio[797]: info: Nov 02 15:33:44 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:44 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:44 volumio volumio[797]: info: ------------------------------ 16ms Nov 02 15:33:44 volumio volumio[797]: info: sendMpdCommand status took 14 milliseconds Nov 02 15:33:44 volumio volumio[797]: info: ------------------------------ 13ms Nov 02 15:33:44 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:44 volumio volumio[797]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 02 15:33:44 volumio volumio[797]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:44 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:44 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:44 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:44 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:44 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1735,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:44 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:44 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:44 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:44 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:44 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:44 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:44 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:44 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:44 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1735,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:44 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:44 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:44 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:44 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:44 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:44 volumio volumio[797]: info: ------------------------------ 54ms Nov 02 15:33:44 volumio volumio[797]: info: ------------------------------ 45ms Nov 02 15:33:45 volumio volumio[797]: info: Nov 02 15:33:45 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:45 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:45 volumio volumio[797]: info: Nov 02 15:33:45 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:45 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:45 volumio volumio[797]: info: Nov 02 15:33:45 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:45 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:45 volumio volumio[797]: info: Nov 02 15:33:45 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:45 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:45 volumio volumio[797]: info: ------------------------------ 10ms Nov 02 15:33:45 volumio volumio[797]: info: sendMpdCommand status took 7 milliseconds Nov 02 15:33:45 volumio volumio[797]: info: ------------------------------ 7ms Nov 02 15:33:45 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:45 volumio volumio[797]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 02 15:33:45 volumio volumio[797]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:45 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:45 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:45 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:45 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:45 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2480,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:45 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:45 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:45 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:45 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:45 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:45 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:45 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:45 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:45 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2480,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:45 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:45 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:45 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:45 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:45 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:45 volumio volumio[797]: info: ------------------------------ 48ms Nov 02 15:33:45 volumio volumio[797]: info: ------------------------------ 49ms Nov 02 15:33:46 volumio volumio[797]: info: Nov 02 15:33:46 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:46 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:46 volumio volumio[797]: info: Nov 02 15:33:46 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:46 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:46 volumio volumio[797]: info: Nov 02 15:33:46 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:46 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:46 volumio volumio[797]: info: Nov 02 15:33:46 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:46 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:46 volumio volumio[797]: info: ------------------------------ 11ms Nov 02 15:33:46 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:33:46 volumio volumio[797]: info: ------------------------------ 12ms Nov 02 15:33:46 volumio volumio[797]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:46 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:33:46 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:46 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:46 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:46 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:46 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:46 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:46 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:46 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:46 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:46 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:46 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:46 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:46 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:46 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:46 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3986,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Absolut relax","artist":"Absolut relax","album":null,"uri":"https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3","trackType":""} Nov 02 15:33:46 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:46 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:46 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:46 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:46 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:46 volumio volumio[797]: info: ------------------------------ 55ms Nov 02 15:33:46 volumio volumio[797]: info: ------------------------------ 53ms Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::volumioStop Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::stPlaybackTimer Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:33:47 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:47 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::serviceStop Nov 02 15:33:47 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::serviceStop Nov 02 15:33:47 volumio volumio[797]: info: [1730561627115] ControllerWebradio::stop Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:33:47 volumio volumio[797]: info: Nov 02 15:33:47 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:47 volumio volumio[797]: info: sendMpdCommand stop took 9 milliseconds Nov 02 15:33:47 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:47 volumio volumio[797]: info: sendMpdCommand status took 1 milliseconds Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:47 volumio volumio[797]: info: Nov 02 15:33:47 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:47 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:47 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:33:47 volumio volumio[797]: info: sendMpdCommand status took 2 milliseconds Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:47 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:47 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:47 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:47 volumio volumio[797]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 02 15:33:47 volumio volumio[797]: info: ------------------------------ 22ms Nov 02 15:33:47 volumio volumio[797]: info: sendMpdCommand playlistinfo took 12 milliseconds Nov 02 15:33:47 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:47 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:47 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:47 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:47 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:47 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:47 volumio volumio[797]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 02 15:33:47 volumio volumio[797]: info: ------------------------------ 41ms Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::ClearQueue Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::clearPlayQueue Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::addQueueItems Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::addQueueItems Nov 02 15:33:50 volumio volumio[797]: info: Adding Item to queue: http://stream.radioparadise.com/rock-flacm Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPlay Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::play index 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::play index undefined Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::startPlaybackTimer Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: info: [1730561630651] ControllerWebradio::clearAddPlayTrack Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand stop took 5 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:50 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand clear took 4 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/rock-flacm" Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:50 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:50 volumio volumio[797]: error: updateQueue error: null Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/rock-flacm" Nov 02 15:33:50 volumio volumio[797]: error: updateQueue error: null Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:50 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 70ms Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand add "http://stream.radioparadise.com/rock-flacm" took 3 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand play Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:50 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand play took 7 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 5ms Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: 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 02 15:33:50 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 28ms Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand status took 21 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand playlistinfo took 20 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand status took 3 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: 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 02 15:33:50 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:50 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 56ms Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand playlistinfo took 27 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand playlistinfo took 25 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: 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 02 15:33:50 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:50 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: 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 02 15:33:50 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:50 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 107ms Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 90ms Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:50 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:50 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:50 volumio volumio[797]: info: Nov 02 15:33:50 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 27ms Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand status took 25 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:33:50 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:50 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"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 02 15:33:50 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:50 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:50 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"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 02 15:33:50 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:50 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:50 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:50 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:50 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:51 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:51 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:51 volumio volumio[797]: info: ------------------------------ 66ms Nov 02 15:33:51 volumio volumio[797]: info: ------------------------------ 47ms Nov 02 15:33:52 volumio volumio[797]: info: Nov 02 15:33:52 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:52 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:52 volumio volumio[797]: info: Nov 02 15:33:52 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:52 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:52 volumio volumio[797]: info: Nov 02 15:33:52 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:52 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:52 volumio volumio[797]: info: Nov 02 15:33:52 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:52 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:52 volumio volumio[797]: info: ------------------------------ 11ms Nov 02 15:33:52 volumio volumio[797]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:33:52 volumio volumio[797]: info: ------------------------------ 8ms Nov 02 15:33:52 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:52 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:33:52 volumio volumio[797]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:52 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:52 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:52 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:52 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:52 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2834,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonic Youth - New Hampshire","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 02 15:33:52 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:52 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:52 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:52 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:52 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:52 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:52 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:52 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:52 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2834,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonic Youth - New Hampshire","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 02 15:33:52 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:52 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:52 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:52 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:52 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:52 volumio volumio[797]: info: ------------------------------ 53ms Nov 02 15:33:52 volumio volumio[797]: info: ------------------------------ 49ms Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::ClearQueue Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::stPlaybackTimer Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::serviceStop Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::serviceStop Nov 02 15:33:56 volumio volumio[797]: info: [1730561636683] ControllerWebradio::stop Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::clearPlayQueue Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::addQueueItems Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::addQueueItems Nov 02 15:33:56 volumio volumio[797]: info: Adding Item to queue: http://stream.radioparadise.com/world-etc-flacm Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioPlay Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::play index 0 Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::play index undefined Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::startPlaybackTimer Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:56 volumio volumio[797]: info: [1730561636710] ControllerWebradio::clearAddPlayTrack Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand stop took 113 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand stop took 87 milliseconds Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:56 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand clear took 8 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/world-etc-flacm" Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:56 volumio volumio[797]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 02 15:33:56 volumio volumio[797]: info: ------------------------------ 23ms Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:56 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:56 volumio volumio[797]: error: updateQueue error: null Nov 02 15:33:56 volumio volumio[797]: info: ------------------------------ 23ms Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand playlistinfo took 20 milliseconds Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:56 volumio volumio[797]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 15:33:56 volumio volumio[797]: info: ------------------------------ 36ms Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" Nov 02 15:33:56 volumio volumio[797]: error: updateQueue error: null Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:56 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:56 volumio volumio[797]: info: ------------------------------ 50ms Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" took 4 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand play Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:56 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:56 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand play took 7 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: ------------------------------ 5ms Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand status took 12 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:56 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:56 volumio volumio[797]: 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 02 15:33:56 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:33:56 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:56 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:56 volumio volumio[797]: info: ------------------------------ 34ms Nov 02 15:33:56 volumio volumio[797]: info: Nov 02 15:33:56 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:56 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:56 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand playlistinfo took 21 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand playlistinfo took 21 milliseconds Nov 02 15:33:56 volumio volumio[797]: info: sendMpdCommand status took 4 milliseconds Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:57 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: 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 02 15:33:57 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:57 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: 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 02 15:33:57 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:57 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: ------------------------------ 83ms Nov 02 15:33:57 volumio volumio[797]: info: ------------------------------ 79ms Nov 02 15:33:57 volumio volumio[797]: info: Nov 02 15:33:57 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:57 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:57 volumio volumio[797]: info: Nov 02 15:33:57 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:57 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:57 volumio volumio[797]: info: sendMpdCommand playlistinfo took 53 milliseconds Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:57 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: 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":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 02 15:33:57 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:57 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: ------------------------------ 84ms Nov 02 15:33:57 volumio volumio[797]: info: Nov 02 15:33:57 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:33:57 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:33:57 volumio volumio[797]: info: Nov 02 15:33:57 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:33:57 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:33:57 volumio volumio[797]: info: ------------------------------ 32ms Nov 02 15:33:57 volumio volumio[797]: info: sendMpdCommand status took 29 milliseconds Nov 02 15:33:57 volumio volumio[797]: info: ------------------------------ 8ms Nov 02 15:33:57 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:33:57 volumio volumio[797]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 02 15:33:57 volumio volumio[797]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:57 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:33:57 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"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 02 15:33:57 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:57 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"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 02 15:33:57 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:33:57 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:33:57 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:33:57 volumio volumio[797]: info: ------------------------------ 73ms Nov 02 15:33:57 volumio volumio[797]: info: ------------------------------ 49ms Nov 02 15:34:00 volumio volumio[797]: info: Nov 02 15:34:00 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:00 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:00 volumio volumio[797]: info: Nov 02 15:34:00 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:00 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:00 volumio volumio[797]: info: Nov 02 15:34:00 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:00 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:00 volumio volumio[797]: info: Nov 02 15:34:00 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:00 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:00 volumio volumio[797]: info: ------------------------------ 16ms Nov 02 15:34:00 volumio volumio[797]: info: sendMpdCommand status took 13 milliseconds Nov 02 15:34:00 volumio volumio[797]: info: ------------------------------ 11ms Nov 02 15:34:00 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:00 volumio volumio[797]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 02 15:34:00 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:00 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:00 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:00 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:00 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:00 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3839,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tosca - Ocean Beat","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 02 15:34:00 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:00 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:00 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:00 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:00 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:00 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:00 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:00 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:00 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3839,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tosca - Ocean Beat","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 02 15:34:00 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:00 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:00 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:00 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:00 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:00 volumio volumio[797]: info: ------------------------------ 59ms Nov 02 15:34:00 volumio volumio[797]: info: ------------------------------ 54ms Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::ClearQueue Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::stPlaybackTimer Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::serviceStop Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::serviceStop Nov 02 15:34:03 volumio volumio[797]: info: [1730561643307] ControllerWebradio::stop Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::clearPlayQueue Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::addQueueItems Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::addQueueItems Nov 02 15:34:03 volumio volumio[797]: info: Adding Item to queue: http://stream.radioparadise.com/rock-flacm Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPlay Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::play index 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::play index undefined Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::startPlaybackTimer Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: [1730561643333] ControllerWebradio::clearAddPlayTrack Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand stop took 107 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand stop took 82 milliseconds Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:03 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand clear took 6 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/rock-flacm" Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 27ms Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:03 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:03 volumio volumio[797]: error: updateQueue error: null Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 28ms Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand playlistinfo took 25 milliseconds Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:03 volumio volumio[797]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 38ms Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/rock-flacm" Nov 02 15:34:03 volumio volumio[797]: error: updateQueue error: null Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:03 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 32ms Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand add "http://stream.radioparadise.com/rock-flacm" took 4 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand play Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:03 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand play took 6 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 6ms Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 3 milliseconds Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: 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 02 15:34:03 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: 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 02 15:34:03 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:03 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 58ms Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 57ms Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:03 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand playlistinfo took 43 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand playlistinfo took 42 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: 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 02 15:34:03 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:03 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: 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 02 15:34:03 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:03 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 104ms Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 99ms Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:03 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:03 volumio volumio[797]: info: Nov 02 15:34:03 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 73ms Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 70 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 16ms Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand status took 13 milliseconds Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:34:03 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:03 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"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 02 15:34:03 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:03 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"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 02 15:34:03 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:03 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:03 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 138ms Nov 02 15:34:03 volumio volumio[797]: info: ------------------------------ 81ms Nov 02 15:34:06 volumio volumio[797]: info: Nov 02 15:34:06 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:06 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:06 volumio volumio[797]: info: Nov 02 15:34:06 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:06 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:06 volumio volumio[797]: info: Nov 02 15:34:06 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:06 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:06 volumio volumio[797]: info: Nov 02 15:34:06 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:06 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:06 volumio volumio[797]: info: ------------------------------ 12ms Nov 02 15:34:06 volumio volumio[797]: info: sendMpdCommand status took 9 milliseconds Nov 02 15:34:06 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:34:06 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:06 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:34:06 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:06 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:06 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:06 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:06 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:06 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3839,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonic Youth - New Hampshire","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 02 15:34:06 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:06 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:06 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:06 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:06 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:06 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:06 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:06 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:06 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3839,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Sonic Youth - New Hampshire","artist":"Radio Paradise Rock Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/rock-flacm","trackType":""} Nov 02 15:34:06 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:06 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:06 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:06 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:06 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:06 volumio volumio[797]: info: ------------------------------ 50ms Nov 02 15:34:06 volumio volumio[797]: info: ------------------------------ 47ms Nov 02 15:34:09 volumio volumio[797]: info: CoreCommandRouter::volumioGetState Nov 02 15:34:11 volumio volumio[797]: info: Saving local item radio-favourites Nov 02 15:34:11 volumio volumio[797]: info: Pushing Favourites {"uri":"http://stream.radioparadise.com/rock-flacm","favourite":false} Nov 02 15:34:23 volumio volumio[797]: info: CoreCommandRouter::volumioGetState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::ClearQueue Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::stPlaybackTimer Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::serviceStop Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::serviceStop Nov 02 15:34:27 volumio volumio[797]: info: [1730561667406] ControllerWebradio::stop Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::clearPlayQueue Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::addQueueItems Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::addQueueItems Nov 02 15:34:27 volumio volumio[797]: info: Adding Item to queue: http://stream.radioparadise.com/world-etc-flacm Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::saveQueue Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushQueue Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::updateTrackBlock Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrackBlock Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPlay Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::play index 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::stop Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::play index undefined Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::startPlaybackTimer Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: [1730561667432] ControllerWebradio::clearAddPlayTrack Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand stop Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand stop took 118 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand stop took 98 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 3 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand clear Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:27 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand clear took 5 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 6 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/world-etc-flacm" Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 17ms Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:27 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:27 volumio volumio[797]: error: updateQueue error: null Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 11ms Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 8 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 21ms Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" Nov 02 15:34:27 volumio volumio[797]: error: updateQueue error: null Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:27 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 43ms Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" took 4 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand play Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:27 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 9ms Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand play took 7 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 4ms Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 10 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 4 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: 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 02 15:34:27 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus stop Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 30ms Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 20 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 18 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 4 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: 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 02 15:34:27 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:27 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 64ms Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:27 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 42 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 41 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: 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 02 15:34:27 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:27 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: 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 02 15:34:27 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:27 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 112ms Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 96ms Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:27 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:27 volumio volumio[797]: info: Nov 02 15:34:27 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 65ms Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 62 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 8ms Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand status took 5 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 9 milliseconds Nov 02 15:34:27 volumio volumio[797]: info: sendMpdCommand playlistinfo took 10 milliseconds Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"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 02 15:34:27 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:27 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":845,"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 02 15:34:27 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:27 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:27 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 119ms Nov 02 15:34:27 volumio volumio[797]: info: ------------------------------ 62ms Nov 02 15:34:30 volumio volumio[797]: info: Nov 02 15:34:30 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:30 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:30 volumio volumio[797]: info: Nov 02 15:34:30 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:30 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:30 volumio volumio[797]: info: Nov 02 15:34:30 volumio volumio[797]: ---------------------------- MPD announces system playlist update Nov 02 15:34:30 volumio volumio[797]: info: Ignoring MPD Status Update Nov 02 15:34:30 volumio volumio[797]: info: Nov 02 15:34:30 volumio volumio[797]: ---------------------------- MPD announces state update: player Nov 02 15:34:30 volumio volumio[797]: info: ControllerMpd::getState Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand status Nov 02 15:34:30 volumio volumio[797]: info: ------------------------------ 11ms Nov 02 15:34:30 volumio volumio[797]: info: sendMpdCommand status took 8 milliseconds Nov 02 15:34:30 volumio volumio[797]: info: ------------------------------ 8ms Nov 02 15:34:30 volumio volumio[797]: info: sendMpdCommand status took 6 milliseconds Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::parseState Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 02 15:34:30 volumio volumio[797]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 02 15:34:30 volumio volumio[797]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:30 volumio volumio[797]: verbose: ControllerMpd::parseTrackInfo Nov 02 15:34:30 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:30 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:30 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3474,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tosca - Ocean Beat","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 02 15:34:30 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:30 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:30 volumio volumio[797]: info: ControllerMpd::pushState Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::servicePushState Nov 02 15:34:30 volumio volumio[797]: info: CorePlayQueue::getTrack 0 Nov 02 15:34:30 volumio volumio[797]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3474,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tosca - Ocean Beat","artist":"Radio Paradise World-Etc Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Nov 02 15:34:30 volumio volumio[797]: verbose: CURRENT POSITION 0 Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::syncState stateService play Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::syncState currentStatus play Nov 02 15:34:30 volumio volumio[797]: info: Received an update from plugin. extracting info from payload Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:30 volumio volumio[797]: info: CoreStateMachine::pushState Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::volumioPushState Nov 02 15:34:30 volumio volumio[797]: info: ------------------------------ 50ms Nov 02 15:34:30 volumio volumio[797]: info: ------------------------------ 47ms Nov 02 15:34:30 volumio volumio[797]: info: CoreCommandRouter::volumioGetState Nov 02 15:34:32 volumio volumio[797]: info: Saving local item radio-favourites Nov 02 15:34:32 volumio volumio[797]: info: Pushing Favourites {"uri":"http://stream.radioparadise.com/world-etc-flacm","favourite":false} Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:34:37 volumio volumio[797]: info: Retrieving Cloud Streaming UI Nov 02 15:34:37 volumio volumio[797]: info: Getting Tidal Cloud Configuration Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:34:37 volumio volumio[797]: info: Getting Qobuz Cloud Configuration Nov 02 15:34:37 volumio volumio[797]: info: Asking plugin for UI Config Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:34:37 volumio volumio[797]: info: Getting Spotify Cloud Configuration Nov 02 15:34:37 volumio volumio[797]: info: Asking plugin for UI Config Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:34:37 volumio volumio[797]: info: Saving Spotify Acccount Nov 02 15:34:37 volumio volumio[797]: info: Got Tidal Cloud Configuration Nov 02 15:34:37 volumio volumio[797]: info: Got it Nov 02 15:34:37 volumio volumio[797]: info: Got it Nov 02 15:34:37 volumio volumio[797]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 02 15:34:37 volumio volumio[797]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::volumioGetBrowseSources Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:34:37 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 02 15:34:41 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:34:42 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Nov 02 15:34:42 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Nov 02 15:34:45 volumio volumio[797]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 02 15:34:47 volumio volumio[797]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 15:34:47 volumio volumio[797]: Error: dns service error: unknown Nov 02 15:34:47 volumio volumio[797]: at MDNSService.on_resolver_done (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:19:30) Nov 02 15:34:47 volumio volumio[797]: at SocketWatcher.MDNSService.self.watcher.callback (/volumio/node_modules/mdns/lib/mdns_service.js:18:40) { Nov 02 15:34:47 volumio volumio[797]: errorCode: -65537 Nov 02 15:34:47 volumio volumio[797]: } Nov 02 15:34:47 volumio volumio[797]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 02 15:34:48 volumio sudo[22194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-02 15:33 Nov 02 15:34:48 volumio sudo[22194]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 10:43:40 AM CEST" VOLUMIO_VERSION="3.378" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4bc817297375b72097a1fade15c6518b"