-- Logs begin at Wed 2025-10-29 09:55:38 +03, end at Wed 2025-10-29 10:00:32 +03. -- Oct 29 09:59:11 volumio volumio[1048]: verbose: New Socket.io Connection to 192.168.1.81:3000 from 192.168.1.72 UA: Dart/3.9 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 29 09:59:15 volumio volumio[1048]: info: CoreCommandRouter::volumioGetVisibleSources Oct 29 09:59:15 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 29 09:59:15 volumio volumio[1048]: info: CoreCommandRouter::volumioGetQueue Oct 29 09:59:15 volumio volumio[1048]: info: CoreStateMachine::getQueue Oct 29 09:59:15 volumio volumio[1048]: info: CorePlayQueue::getQueue Oct 29 09:59:17 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 29 09:59:17 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 29 09:59:17 volumio volumio[1048]: info: Preload queue cleared Oct 29 09:59:19 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 29 09:59:19 volumio volumio[1048]: info: Getting webradio selection Oct 29 09:59:19 volumio volumio[1048]: info: Preload queue cleared Oct 29 09:59:22 volumio volumio[1048]: info: Preload queue cleared Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::ClearQueue Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::stop Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::stPlaybackTimer Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::updateTrackBlock Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrackBlock Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::serviceStop Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::serviceStop Oct 29 09:59:22 volumio volumio[1048]: info: [1761721162641] ControllerWebradio::stop Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::clearPlayQueue Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::saveQueue Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::volumioPushQueue Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::addQueueItems Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::addQueueItems Oct 29 09:59:22 volumio volumio[1048]: info: Preload queue cleared Oct 29 09:59:22 volumio volumio[1048]: info: Adding Item to queue: http://stream.radioparadise.com/world-etc-flacm Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::volumioPushQueue Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::saveQueue Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::updateTrackBlock Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrackBlock Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::volumioPlay Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::play index 0 Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::stop Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::play index undefined Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::startPlaybackTimer Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: error: Could not retrieve plugin miscellanea metavolumio Oct 29 09:59:22 volumio volumio[1048]: info: [1761721162664] ControllerWebradio::clearAddPlayTrack Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 09:59:22 volumio volumio[1048]: info: Oct 29 09:59:22 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:22 volumio volumio[1048]: info: sendMpdCommand stop took 30 milliseconds Oct 29 09:59:22 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:22 volumio volumio[1048]: info: sendMpdCommand stop took 8 milliseconds Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 09:59:22 volumio volumio[1048]: info: Oct 29 09:59:22 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:22 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:22 volumio volumio[1048]: info: Oct 29 09:59:22 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:22 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:22 volumio volumio[1048]: info: Oct 29 09:59:22 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:22 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:22 volumio volumio[1048]: info: sendMpdCommand status took 4 milliseconds Oct 29 09:59:22 volumio volumio[1048]: info: sendMpdCommand clear took 4 milliseconds Oct 29 09:59:22 volumio volumio[1048]: info: sendMpdCommand status took 4 milliseconds Oct 29 09:59:22 volumio volumio[1048]: info: sendMpdCommand status took 2 milliseconds Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/world-etc-flacm" Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:22 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 29 09:59:22 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:22 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:22 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:22 volumio volumio[1048]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 29 09:59:22 volumio volumio[1048]: info: ------------------------------ 33ms Oct 29 09:59:22 volumio volumio[1048]: info: ------------------------------ 32ms Oct 29 09:59:22 volumio volumio[1048]: info: Oct 29 09:59:22 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:22 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:22 volumio volumio[1048]: info: Oct 29 09:59:22 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:22 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:22 volumio volumio[1048]: error: updateQueue error: null Oct 29 09:59:22 volumio volumio[1048]: info: ------------------------------ 36ms Oct 29 09:59:22 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 34 milliseconds Oct 29 09:59:22 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:22 volumio volumio[1048]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 29 09:59:22 volumio volumio[1048]: info: ------------------------------ 43ms Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" Oct 29 09:59:23 volumio volumio[1048]: error: updateQueue error: null Oct 29 09:59:23 volumio volumio[1048]: error: updateQueue error: null Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:23 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 898ms Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 897ms Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand add "http://stream.radioparadise.com/world-etc-flacm" took 2 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand play Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:23 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:23 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 4ms Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand play took 3 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 2ms Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 2ms Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 24 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 25 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 24 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 1 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: 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":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus stop Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 29ms Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 2 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 1 milliseconds Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: 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":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: 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":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: 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":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 75ms Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 75ms Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 53ms Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 47 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 46 milliseconds Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: 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":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: 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":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 83ms Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 82ms Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:23 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:23 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:23 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:23 volumio volumio[1048]: info: Oct 29 09:59:23 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 11ms Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 6 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 4ms Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 5ms Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand status took 7 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"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: Global Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"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: Global Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 50ms Oct 29 09:59:23 volumio volumio[1048]: info: ------------------------------ 47ms Oct 29 09:59:23 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 38 milliseconds Oct 29 09:59:23 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:23 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"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: Global Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Oct 29 09:59:23 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:23 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:23 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:23 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:23 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:24 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:24 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:24 volumio volumio[1048]: info: ------------------------------ 79ms Oct 29 09:59:26 volumio volumio[1048]: info: Oct 29 09:59:26 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:26 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:26 volumio volumio[1048]: info: Oct 29 09:59:26 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:26 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:26 volumio volumio[1048]: info: Oct 29 09:59:26 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:26 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:26 volumio volumio[1048]: info: Oct 29 09:59:26 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:26 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:26 volumio volumio[1048]: info: Oct 29 09:59:26 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:26 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:26 volumio volumio[1048]: info: Oct 29 09:59:26 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:26 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:26 volumio volumio[1048]: info: ------------------------------ 8ms Oct 29 09:59:26 volumio volumio[1048]: info: sendMpdCommand status took 6 milliseconds Oct 29 09:59:26 volumio volumio[1048]: info: ------------------------------ 5ms Oct 29 09:59:26 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 09:59:26 volumio volumio[1048]: info: ------------------------------ 4ms Oct 29 09:59:26 volumio volumio[1048]: info: sendMpdCommand status took 2 milliseconds Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:26 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 09:59:26 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 09:59:26 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:26 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:26 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:26 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:26 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3637,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tiken Jah Fakoly - Les Martyrs","artist":"Radio Paradise: Global Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Oct 29 09:59:26 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:26 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:26 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:26 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:26 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3637,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tiken Jah Fakoly - Les Martyrs","artist":"Radio Paradise: Global Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Oct 29 09:59:26 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:26 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:26 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:26 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:26 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3637,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Tiken Jah Fakoly - Les Martyrs","artist":"Radio Paradise: Global Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/world-etc-flacm","trackType":""} Oct 29 09:59:26 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:26 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:26 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:26 volumio volumio[1048]: info: ------------------------------ 50ms Oct 29 09:59:26 volumio volumio[1048]: info: ------------------------------ 48ms Oct 29 09:59:26 volumio volumio[1048]: info: ------------------------------ 46ms Oct 29 09:59:53 volumio volumio[1048]: info: Preload queue cleared Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::ClearQueue Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::stop Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::stPlaybackTimer Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::updateTrackBlock Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrackBlock Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::serviceStop Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::serviceStop Oct 29 09:59:53 volumio volumio[1048]: info: [1761721193579] ControllerWebradio::stop Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::clearPlayQueue Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::saveQueue Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::volumioPushQueue Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::addQueueItems Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::addQueueItems Oct 29 09:59:53 volumio volumio[1048]: info: Preload queue cleared Oct 29 09:59:53 volumio volumio[1048]: info: Adding Item to queue: http://stream.radioparadise.com/mellow-flacm Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::volumioPushQueue Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::saveQueue Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::updateTrackBlock Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrackBlock Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::volumioPlay Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::play index 0 Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::stop Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::play index undefined Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::startPlaybackTimer Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: error: Could not retrieve plugin miscellanea metavolumio Oct 29 09:59:53 volumio volumio[1048]: info: [1761721193599] ControllerWebradio::clearAddPlayTrack Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand stop took 36 milliseconds Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:53 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand stop took 17 milliseconds Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:53 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:53 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:53 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand status took 6 milliseconds Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand clear took 5 milliseconds Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand status took 4 milliseconds Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand status took 2 milliseconds Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/mellow-flacm" Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:53 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 29 09:59:53 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:53 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:53 volumio volumio[1048]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 31ms Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 30ms Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:53 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:53 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:53 volumio volumio[1048]: error: updateQueue error: null Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 34ms Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 32 milliseconds Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:53 volumio volumio[1048]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 42ms Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/mellow-flacm" Oct 29 09:59:53 volumio volumio[1048]: error: updateQueue error: null Oct 29 09:59:53 volumio volumio[1048]: error: updateQueue error: null Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:53 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 109ms Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 109ms Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand add "http://stream.radioparadise.com/mellow-flacm" took 3 milliseconds Oct 29 09:59:53 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 29 09:59:53 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand play Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:53 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:53 volumio volumio[1048]: info: Oct 29 09:59:53 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:53 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 8ms Oct 29 09:59:53 volumio volumio[1048]: info: sendMpdCommand play took 7 milliseconds Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 4ms Oct 29 09:59:53 volumio volumio[1048]: info: ------------------------------ 2ms Oct 29 09:59:54 volumio volumio[1048]: info: Oct 29 09:59:54 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:54 volumio volumio[1048]: info: Oct 29 09:59:54 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:54 volumio volumio[1048]: info: Oct 29 09:59:54 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand status took 33 milliseconds Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:54 volumio volumio[1048]: info: Oct 29 09:59:54 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand status took 33 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand status took 32 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:54 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus stop Oct 29 09:59:54 volumio volumio[1048]: info: ------------------------------ 37ms Oct 29 09:59:54 volumio volumio[1048]: info: Oct 29 09:59:54 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:54 volumio volumio[1048]: info: Oct 29 09:59:54 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand status took 6 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 6 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand status took 5 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:54 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:54 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:54 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:54 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: ------------------------------ 81ms Oct 29 09:59:54 volumio volumio[1048]: info: ------------------------------ 80ms Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 41 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 40 milliseconds Oct 29 09:59:54 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 40 milliseconds Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:54 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:54 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:54 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:54 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:54 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":null,"album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:54 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:54 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:54 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:54 volumio volumio[1048]: info: ------------------------------ 82ms Oct 29 09:59:54 volumio volumio[1048]: info: ------------------------------ 80ms Oct 29 09:59:54 volumio volumio[1048]: info: ------------------------------ 80ms Oct 29 09:59:55 volumio volumio[1048]: info: Oct 29 09:59:55 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:55 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:55 volumio volumio[1048]: info: Oct 29 09:59:55 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:55 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:55 volumio volumio[1048]: info: Oct 29 09:59:55 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:55 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:55 volumio volumio[1048]: info: Oct 29 09:59:55 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:55 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:55 volumio volumio[1048]: info: Oct 29 09:59:55 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:55 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:55 volumio volumio[1048]: info: Oct 29 09:59:55 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:55 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:55 volumio volumio[1048]: info: ------------------------------ 13ms Oct 29 09:59:55 volumio volumio[1048]: info: sendMpdCommand status took 11 milliseconds Oct 29 09:59:55 volumio volumio[1048]: info: ------------------------------ 10ms Oct 29 09:59:55 volumio volumio[1048]: info: sendMpdCommand status took 8 milliseconds Oct 29 09:59:55 volumio volumio[1048]: info: ------------------------------ 7ms Oct 29 09:59:55 volumio volumio[1048]: info: sendMpdCommand status took 6 milliseconds Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:55 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 09:59:55 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 09:59:55 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:55 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:55 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:55 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:55 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise: Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:55 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:55 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:55 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:55 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:55 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":68,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise: Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:55 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:55 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:55 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:55 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:55 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":114,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"mellow-flacm","artist":"Radio Paradise: Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:55 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:55 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:55 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:55 volumio volumio[1048]: info: ------------------------------ 77ms Oct 29 09:59:55 volumio volumio[1048]: info: ------------------------------ 74ms Oct 29 09:59:55 volumio volumio[1048]: info: ------------------------------ 71ms Oct 29 09:59:59 volumio volumio[1048]: info: Oct 29 09:59:59 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:59 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:59 volumio volumio[1048]: info: Oct 29 09:59:59 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:59 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:59 volumio volumio[1048]: info: Oct 29 09:59:59 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:59 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:59 volumio volumio[1048]: info: Oct 29 09:59:59 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:59 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:59 volumio volumio[1048]: info: Oct 29 09:59:59 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 09:59:59 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 09:59:59 volumio volumio[1048]: info: Oct 29 09:59:59 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 09:59:59 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 09:59:59 volumio volumio[1048]: info: ------------------------------ 7ms Oct 29 09:59:59 volumio volumio[1048]: info: sendMpdCommand status took 7 milliseconds Oct 29 09:59:59 volumio volumio[1048]: info: ------------------------------ 6ms Oct 29 09:59:59 volumio volumio[1048]: info: sendMpdCommand status took 5 milliseconds Oct 29 09:59:59 volumio volumio[1048]: info: ------------------------------ 4ms Oct 29 09:59:59 volumio volumio[1048]: info: sendMpdCommand status took 4 milliseconds Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 09:59:59 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 09:59:59 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 09:59:59 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 29 09:59:59 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 09:59:59 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:59 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:59 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4759,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beck - Heart is a Drum","artist":"Radio Paradise: Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:59 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:59 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:59 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:59 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:59 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4759,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beck - Heart is a Drum","artist":"Radio Paradise: Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:59 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:59 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:59 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 09:59:59 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 09:59:59 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":4759,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Beck - Heart is a Drum","artist":"Radio Paradise: Mellow Mix (flac) - playlist: radioparadise.com","album":null,"uri":"http://stream.radioparadise.com/mellow-flacm","trackType":""} Oct 29 09:59:59 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 09:59:59 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 09:59:59 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 09:59:59 volumio volumio[1048]: info: ------------------------------ 55ms Oct 29 09:59:59 volumio volumio[1048]: info: ------------------------------ 54ms Oct 29 09:59:59 volumio volumio[1048]: info: ------------------------------ 55ms Oct 29 10:00:07 volumio volumio[1048]: info: Preload queue cleared Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::ClearQueue Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::stop Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::stPlaybackTimer Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::updateTrackBlock Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrackBlock Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::serviceStop Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::serviceStop Oct 29 10:00:07 volumio volumio[1048]: info: [1761721207150] ControllerWebradio::stop Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::clearPlayQueue Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::saveQueue Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::volumioPushQueue Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::addQueueItems Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::addQueueItems Oct 29 10:00:07 volumio volumio[1048]: info: Preload queue cleared Oct 29 10:00:07 volumio volumio[1048]: info: Adding Item to queue: http://mscp3.live-streams.nl:8250/class-flac.flac Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::volumioPushQueue Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::saveQueue Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::updateTrackBlock Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrackBlock Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::volumioPlay Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::play index 0 Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::stop Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::play index undefined Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::startPlaybackTimer Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: error: Could not retrieve plugin miscellanea metavolumio Oct 29 10:00:07 volumio volumio[1048]: info: [1761721207165] ControllerWebradio::clearAddPlayTrack Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand stop Oct 29 10:00:07 volumio volumio[1048]: info: sendMpdCommand stop took 33 milliseconds Oct 29 10:00:07 volumio volumio[1048]: info: Oct 29 10:00:07 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:07 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:07 volumio volumio[1048]: info: sendMpdCommand stop took 20 milliseconds Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand clear Oct 29 10:00:07 volumio volumio[1048]: info: Oct 29 10:00:07 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:07 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:07 volumio volumio[1048]: info: Oct 29 10:00:07 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:07 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:07 volumio volumio[1048]: info: Oct 29 10:00:07 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:07 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:07 volumio volumio[1048]: info: sendMpdCommand status took 7 milliseconds Oct 29 10:00:07 volumio volumio[1048]: info: sendMpdCommand clear took 6 milliseconds Oct 29 10:00:07 volumio volumio[1048]: info: sendMpdCommand status took 5 milliseconds Oct 29 10:00:07 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8250/class-flac.flac" Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:07 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 29 10:00:07 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:07 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:07 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:07 volumio volumio[1048]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Oct 29 10:00:07 volumio volumio[1048]: info: ------------------------------ 27ms Oct 29 10:00:07 volumio volumio[1048]: info: ------------------------------ 27ms Oct 29 10:00:07 volumio volumio[1048]: info: Oct 29 10:00:07 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:07 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:07 volumio volumio[1048]: info: Oct 29 10:00:07 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:07 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:07 volumio volumio[1048]: error: updateQueue error: null Oct 29 10:00:07 volumio volumio[1048]: info: ------------------------------ 27ms Oct 29 10:00:07 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 24 milliseconds Oct 29 10:00:07 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:07 volumio volumio[1048]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 29 10:00:07 volumio volumio[1048]: info: ------------------------------ 35ms Oct 29 10:00:08 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8250/class-flac.flac" Oct 29 10:00:08 volumio volumio[1048]: error: updateQueue error: null Oct 29 10:00:08 volumio volumio[1048]: info: Oct 29 10:00:08 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:08 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:08 volumio volumio[1048]: info: ------------------------------ 1034ms Oct 29 10:00:08 volumio volumio[1048]: info: ------------------------------ 1033ms Oct 29 10:00:08 volumio volumio[1048]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8250/class-flac.flac" took 2 milliseconds Oct 29 10:00:08 volumio volumio[1048]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 29 10:00:08 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand play Oct 29 10:00:08 volumio volumio[1048]: info: Oct 29 10:00:08 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:08 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:08 volumio volumio[1048]: info: Oct 29 10:00:08 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:08 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:08 volumio volumio[1048]: info: ------------------------------ 4ms Oct 29 10:00:08 volumio volumio[1048]: info: sendMpdCommand play took 3 milliseconds Oct 29 10:00:08 volumio volumio[1048]: info: ------------------------------ 2ms Oct 29 10:00:08 volumio volumio[1048]: info: ------------------------------ 1ms Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 5 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 5 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 4 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 2 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: 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":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus stop Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 9ms Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 2 milliseconds Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: 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":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: 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":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: 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":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 60ms Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 60ms Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 56ms Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 49 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 50 milliseconds Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: 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":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: 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":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 80ms Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 79ms Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:09 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:09 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces system playlist update Oct 29 10:00:09 volumio volumio[1048]: info: Ignoring MPD Status Update Oct 29 10:00:09 volumio volumio[1048]: info: Oct 29 10:00:09 volumio volumio[1048]: ---------------------------- MPD announces state update: player Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::getState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand status Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 4ms Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 3ms Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 2ms Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand status took 3 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseState Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: 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":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 24ms Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 21 milliseconds Oct 29 10:00:09 volumio volumio[1048]: info: sendMpdCommand playlistinfo took 21 milliseconds Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: verbose: ControllerMpd::parseTrackInfo Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ControllerMpd::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::servicePushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"} Oct 29 10:00:09 volumio volumio[1048]: verbose: CURRENT POSITION 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState stateService play Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::syncState currentStatus play Oct 29 10:00:09 volumio volumio[1048]: info: Received an update from plugin. extracting info from payload Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CorePlayQueue::getTrack 0 Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreStateMachine::pushState Oct 29 10:00:09 volumio volumio[1048]: info: CoreCommandRouter::volumioPushState Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 52ms Oct 29 10:00:09 volumio volumio[1048]: info: ------------------------------ 52ms Oct 29 10:00:25 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 29 10:00:25 volumio volumio[1048]: info: Preload queue cleared Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 29 10:00:28 volumio volumio[1048]: error: Could not retrieve plugin music_service streaming_services Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::volumioGetBrowseSources Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 29 10:00:28 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 29 10:00:31 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 29 10:00:31 volumio volumio[1048]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 29 10:00:32 volumio volumio[1048]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 10:00:32 volumio volumio[1048]: Error: getaddrinfo -3007 Oct 29 10:00:32 volumio volumio[1048]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Oct 29 10:00:32 volumio volumio[1048]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Oct 29 10:00:32 volumio volumio[1048]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Oct 29 10:00:32 volumio volumio[1048]: code: -3007, Oct 29 10:00:32 volumio volumio[1048]: errno: -3007, Oct 29 10:00:32 volumio volumio[1048]: syscall: 'getaddrinfo' Oct 29 10:00:32 volumio volumio[1048]: } Oct 29 10:00:32 volumio volumio[1048]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 29 10:00:32 volumio sudo[2965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-29 09:59 Oct 29 10:00:32 volumio sudo[2965]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Nov 25 05:13:21 AM UTC 2024" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="vim3" VOLUMIO_DEVICENAME="Khadas VIM3" VOLUMIO_HASH="074917d1ca9e9870e4f3627f241e04c9"