-- Logs begin at Thu 2019-02-14 13:12:00 MSK, end at Wed 2026-02-11 21:07:20 MSK. -- Feb 11 21:06:06 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 11 21:06:06 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:07 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 11 21:06:07 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:09 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::ClearQueue Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::stPlaybackTimer Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::serviceStop Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::serviceStop Feb 11 21:06:09 volumio volumio[965]: info: [1770833169410] ControllerWebradio::stop Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::clearPlayQueue Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::addQueueItems Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::addQueueItems Feb 11 21:06:09 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:09 volumio volumio[965]: info: Adding Item to queue: http://mscp2.live-streams.nl:8100/flac.flac Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::volumioPlay Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::play index 0 Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::play index undefined Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::startPlaybackTimer Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: [1770833169459] ControllerWebradio::clearAddPlayTrack Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand stop took 59 milliseconds Feb 11 21:06:09 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand stop took 10 milliseconds Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:09 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:09 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:09 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand status took 12 milliseconds Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand clear took 12 milliseconds Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand status took 10 milliseconds Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand status took 7 milliseconds Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand load "http://mscp2.live-streams.nl:8100/flac.flac" Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:09 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:09 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:09 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:09 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 68ms Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 68ms Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:09 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:09 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:09 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 72ms Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand playlistinfo took 69 milliseconds Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:09 volumio volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 88ms Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand add "http://mscp2.live-streams.nl:8100/flac.flac" Feb 11 21:06:09 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:09 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:09 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 393ms Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 391ms Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand add "http://mscp2.live-streams.nl:8100/flac.flac" took 4 milliseconds Feb 11 21:06:09 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 21:06:09 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand play Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:09 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:09 volumio volumio[965]: info: Feb 11 21:06:09 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:09 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 13ms Feb 11 21:06:09 volumio volumio[965]: info: sendMpdCommand play took 9 milliseconds Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 8ms Feb 11 21:06:09 volumio volumio[965]: info: ------------------------------ 6ms Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 9 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 13 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 5 milliseconds Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 72ms Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 134ms Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 133ms Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 114 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 112 milliseconds Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 274ms Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 268ms Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 266ms Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:10 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:10 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:10 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:10 volumio volumio[965]: info: Feb 11 21:06:10 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 13ms Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 11 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 11ms Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 9 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 8ms Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 11 21:06:10 volumio volumio[965]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Hi Online","album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Hi Online","album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Hi Online","album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:10 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:10 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:10 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 157ms Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 155ms Feb 11 21:06:10 volumio volumio[965]: info: ------------------------------ 153ms Feb 11 21:06:12 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::ClearQueue Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::stPlaybackTimer Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::serviceStop Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::serviceStop Feb 11 21:06:12 volumio volumio[965]: info: [1770833172785] ControllerWebradio::stop Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::clearPlayQueue Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::addQueueItems Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::addQueueItems Feb 11 21:06:12 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:12 volumio volumio[965]: info: Adding Item to queue: http://secure.live-streams.nl/flac.flac Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::volumioPlay Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::play index 0 Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::play index undefined Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::startPlaybackTimer Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: [1770833172830] ControllerWebradio::clearAddPlayTrack Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:12 volumio volumio[965]: info: Feb 11 21:06:12 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:12 volumio volumio[965]: info: sendMpdCommand stop took 55 milliseconds Feb 11 21:06:12 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:12 volumio volumio[965]: info: sendMpdCommand stop took 10 milliseconds Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 21:06:12 volumio volumio[965]: info: Feb 11 21:06:12 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:12 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:12 volumio volumio[965]: info: Feb 11 21:06:12 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:12 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:12 volumio volumio[965]: info: Feb 11 21:06:12 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:12 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:12 volumio volumio[965]: info: sendMpdCommand status took 13 milliseconds Feb 11 21:06:12 volumio volumio[965]: info: sendMpdCommand clear took 12 milliseconds Feb 11 21:06:12 volumio volumio[965]: info: sendMpdCommand status took 11 milliseconds Feb 11 21:06:12 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand load "http://secure.live-streams.nl/flac.flac" Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:12 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:12 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:12 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:12 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:12 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:12 volumio volumio[965]: info: ------------------------------ 61ms Feb 11 21:06:12 volumio volumio[965]: info: ------------------------------ 60ms Feb 11 21:06:12 volumio volumio[965]: info: Feb 11 21:06:12 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:12 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:12 volumio volumio[965]: info: Feb 11 21:06:12 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:12 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:12 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:12 volumio volumio[965]: info: ------------------------------ 62ms Feb 11 21:06:12 volumio volumio[965]: info: sendMpdCommand playlistinfo took 59 milliseconds Feb 11 21:06:12 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:12 volumio volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 11 21:06:12 volumio volumio[965]: info: ------------------------------ 78ms Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand add "http://secure.live-streams.nl/flac.flac" Feb 11 21:06:14 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:14 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:14 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:14 volumio volumio[965]: info: ------------------------------ 1404ms Feb 11 21:06:14 volumio volumio[965]: info: ------------------------------ 1402ms Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand add "http://secure.live-streams.nl/flac.flac" took 5 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand play Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:14 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:14 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:14 volumio volumio[965]: info: ------------------------------ 12ms Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand play took 10 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: ------------------------------ 8ms Feb 11 21:06:14 volumio volumio[965]: info: ------------------------------ 6ms Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand status took 14 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand status took 12 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand status took 10 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:14 volumio volumio[965]: info: Feb 11 21:06:14 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand status took 13 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 11 21:06:14 volumio volumio[965]: info: sendMpdCommand status took 5 milliseconds Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:14 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:14 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:14 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:14 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:14 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:14 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:14 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:14 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:14 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:14 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:14 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:14 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:14 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:14 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:14 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:14 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:14 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:14 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:14 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:14 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:14 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:14 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:14 volumio volumio[965]: info: ------------------------------ 81ms Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 235ms Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 234ms Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 232ms Feb 11 21:06:15 volumio volumio[965]: info: Feb 11 21:06:15 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:15 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:15 volumio volumio[965]: info: Feb 11 21:06:15 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand playlistinfo took 220 milliseconds Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand playlistinfo took 220 milliseconds Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:15 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:15 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:15 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:15 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:15 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:15 volumio volumio[965]: 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":"Seven Cities (Original Atlantis Mix)","artist":"Solarstone","album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:15 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:15 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 339ms Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 329ms Feb 11 21:06:15 volumio volumio[965]: info: Feb 11 21:06:15 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:15 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:15 volumio volumio[965]: info: Feb 11 21:06:15 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:15 volumio volumio[965]: info: Feb 11 21:06:15 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:15 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:15 volumio volumio[965]: info: Feb 11 21:06:15 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 148ms Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand status took 144 milliseconds Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 13ms Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand status took 12 milliseconds Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 14ms Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand status took 12 milliseconds Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:15 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:15 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seven Cities (Original Atlantis Mix)","artist":"Solarstone","album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:15 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:15 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:15 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:15 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seven Cities (Original Atlantis Mix)","artist":"Solarstone","album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:15 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:15 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 256ms Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 120ms Feb 11 21:06:15 volumio volumio[965]: info: sendMpdCommand playlistinfo took 107 milliseconds Feb 11 21:06:15 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:15 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:15 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:15 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1212,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Seven Cities (Original Atlantis Mix)","artist":"Solarstone","album":null,"uri":"http://secure.live-streams.nl/flac.flac","trackType":"flac"} Feb 11 21:06:15 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:15 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:15 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:15 volumio volumio[965]: info: ------------------------------ 169ms Feb 11 21:06:16 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::ClearQueue Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::stPlaybackTimer Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::serviceStop Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::serviceStop Feb 11 21:06:16 volumio volumio[965]: info: [1770833176537] ControllerWebradio::stop Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::clearPlayQueue Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::addQueueItems Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::addQueueItems Feb 11 21:06:16 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:16 volumio volumio[965]: info: Adding Item to queue: http://stream.lesonparisien.com/live.flac Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::volumioPlay Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::play index 0 Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::play index undefined Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::startPlaybackTimer Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: [1770833176579] ControllerWebradio::clearAddPlayTrack Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:16 volumio volumio[965]: info: Feb 11 21:06:16 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:16 volumio volumio[965]: info: sendMpdCommand stop took 51 milliseconds Feb 11 21:06:16 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:16 volumio volumio[965]: info: sendMpdCommand stop took 11 milliseconds Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 21:06:16 volumio volumio[965]: info: Feb 11 21:06:16 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:16 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:16 volumio volumio[965]: info: Feb 11 21:06:16 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:16 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:16 volumio volumio[965]: info: Feb 11 21:06:16 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:16 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:16 volumio volumio[965]: info: sendMpdCommand status took 74 milliseconds Feb 11 21:06:16 volumio volumio[965]: info: sendMpdCommand clear took 74 milliseconds Feb 11 21:06:16 volumio volumio[965]: info: sendMpdCommand status took 24 milliseconds Feb 11 21:06:16 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand load "http://stream.lesonparisien.com/live.flac" Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:16 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:16 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:16 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:16 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:16 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:16 volumio volumio[965]: info: ------------------------------ 81ms Feb 11 21:06:16 volumio volumio[965]: info: ------------------------------ 79ms Feb 11 21:06:16 volumio volumio[965]: info: Feb 11 21:06:16 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:16 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:16 volumio volumio[965]: info: Feb 11 21:06:16 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:16 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:16 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:16 volumio volumio[965]: info: ------------------------------ 71ms Feb 11 21:06:16 volumio volumio[965]: info: sendMpdCommand playlistinfo took 67 milliseconds Feb 11 21:06:16 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:16 volumio volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 11 21:06:16 volumio volumio[965]: info: ------------------------------ 150ms Feb 11 21:06:18 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand add "http://stream.lesonparisien.com/live.flac" Feb 11 21:06:18 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:18 volumio volumio[965]: info: Feb 11 21:06:18 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:18 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:18 volumio volumio[965]: info: ------------------------------ 1310ms Feb 11 21:06:18 volumio volumio[965]: info: ------------------------------ 1310ms Feb 11 21:06:18 volumio volumio[965]: info: sendMpdCommand add "http://stream.lesonparisien.com/live.flac" took 4 milliseconds Feb 11 21:06:18 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 21:06:18 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand play Feb 11 21:06:18 volumio volumio[965]: info: Feb 11 21:06:18 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:18 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:18 volumio volumio[965]: info: Feb 11 21:06:18 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:18 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:18 volumio volumio[965]: info: ------------------------------ 10ms Feb 11 21:06:18 volumio volumio[965]: info: sendMpdCommand play took 8 milliseconds Feb 11 21:06:18 volumio volumio[965]: info: ------------------------------ 6ms Feb 11 21:06:18 volumio volumio[965]: info: ------------------------------ 4ms Feb 11 21:06:29 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::ClearQueue Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::clearPlayQueue Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::addQueueItems Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::addQueueItems Feb 11 21:06:29 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:29 volumio volumio[965]: info: Adding Item to queue: http://mscp2.live-streams.nl:8100/flac.flac Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPlay Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::play index 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::play index undefined Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::startPlaybackTimer Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: info: [1770833189384] ControllerWebradio::clearAddPlayTrack Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand stop took 8 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:29 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 4 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand clear took 4 milliseconds Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand load "http://mscp2.live-streams.nl:8100/flac.flac" Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 12ms Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:29 volumio volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 20ms Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand add "http://mscp2.live-streams.nl:8100/flac.flac" Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:29 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 241 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 239 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand add "http://mscp2.live-streams.nl:8100/flac.flac" took 4 milliseconds Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand play Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 11 21:06:29 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState stateService stop Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: No code Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Feb 11 21:06:29 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState stateService stop Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: No code Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 396ms Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 396ms Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:29 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:29 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 168ms Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand play took 153 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 8ms Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 6ms Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:29 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:29 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 33ms Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 31ms Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 12 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 10 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: info: Feb 11 21:06:29 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 27 milliseconds Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand playlistinfo took 37 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand playlistinfo took 37 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand playlistinfo took 28 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 25 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand status took 24 milliseconds Feb 11 21:06:29 volumio volumio[965]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:29 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:29 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:29 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:29 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:29 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:29 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:29 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:29 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:29 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:29 volumio volumio[965]: info: ------------------------------ 107ms Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 211ms Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 209ms Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 206ms Feb 11 21:06:30 volumio volumio[965]: info: Feb 11 21:06:30 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:30 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:30 volumio volumio[965]: info: Feb 11 21:06:30 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand playlistinfo took 162 milliseconds Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand playlistinfo took 162 milliseconds Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:30 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:30 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: 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":"flac.flac","artist":null,"album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:30 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:30 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 308ms Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 307ms Feb 11 21:06:30 volumio volumio[965]: info: Feb 11 21:06:30 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:30 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:30 volumio volumio[965]: info: Feb 11 21:06:30 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:30 volumio volumio[965]: info: Feb 11 21:06:30 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:30 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:30 volumio volumio[965]: info: Feb 11 21:06:30 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 172ms Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand status took 168 milliseconds Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 15ms Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand status took 14 milliseconds Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 13ms Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand status took 10 milliseconds Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 11 21:06:30 volumio volumio[965]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:30 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Hi Online","album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:30 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:30 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Hi Online","album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:30 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:30 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1098,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Hi Online","album":null,"uri":"http://mscp2.live-streams.nl:8100/flac.flac","trackType":"flac"} Feb 11 21:06:30 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:30 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:30 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 328ms Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 171ms Feb 11 21:06:30 volumio volumio[965]: info: ------------------------------ 169ms Feb 11 21:06:38 volumio volumio[965]: Searching all installed plugins Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Feb 11 21:06:38 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Feb 11 21:06:40 volumio volumio[965]: Searching all installed plugins Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Feb 11 21:06:40 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Feb 11 21:06:41 volumio volumio[965]: Searching all installed plugins Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Feb 11 21:06:41 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Feb 11 21:06:43 volumio volumio[965]: error: Search in plugin youtube2 timed out Feb 11 21:06:43 volumio volumio[965]: info: All search sources collected, pushing search results Feb 11 21:06:45 volumio volumio[965]: error: Search in plugin webradio timed out Feb 11 21:06:45 volumio volumio[965]: error: Search in plugin youtube2 timed out Feb 11 21:06:45 volumio volumio[965]: info: All search sources collected, pushing search results Feb 11 21:06:46 volumio volumio[965]: Searching all installed plugins Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Feb 11 21:06:46 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Feb 11 21:06:46 volumio volumio[965]: error: Search in plugin webradio timed out Feb 11 21:06:46 volumio volumio[965]: error: Search in plugin youtube2 timed out Feb 11 21:06:46 volumio volumio[965]: info: All search sources collected, pushing search results Feb 11 21:06:51 volumio volumio[965]: Searching all installed plugins Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Feb 11 21:06:51 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Feb 11 21:06:51 volumio volumio[965]: error: Search in plugin youtube2 timed out Feb 11 21:06:51 volumio volumio[965]: info: All search sources collected, pushing search results Feb 11 21:06:53 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::ClearQueue Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::stPlaybackTimer Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::serviceStop Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::serviceStop Feb 11 21:06:53 volumio volumio[965]: info: [1770833213823] ControllerWebradio::stop Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::clearPlayQueue Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::addQueueItems Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::addQueueItems Feb 11 21:06:53 volumio volumio[965]: info: Preload queue cleared Feb 11 21:06:53 volumio volumio[965]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s224874 Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::volumioPushQueue Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::saveQueue Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::updateTrackBlock Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrackBlock Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::volumioPlay Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::play index 0 Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::stop Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::play index undefined Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::startPlaybackTimer Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: [1770833213877] ControllerWebradio::clearAddPlayTrack Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand stop Feb 11 21:06:53 volumio volumio[965]: info: Feb 11 21:06:53 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:53 volumio volumio[965]: info: sendMpdCommand stop took 65 milliseconds Feb 11 21:06:53 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:53 volumio volumio[965]: info: sendMpdCommand stop took 11 milliseconds Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand clear Feb 11 21:06:53 volumio volumio[965]: info: Feb 11 21:06:53 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:53 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:53 volumio volumio[965]: info: Feb 11 21:06:53 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:53 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:53 volumio volumio[965]: info: Feb 11 21:06:53 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:53 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:53 volumio volumio[965]: info: sendMpdCommand status took 11 milliseconds Feb 11 21:06:53 volumio volumio[965]: info: sendMpdCommand clear took 10 milliseconds Feb 11 21:06:53 volumio volumio[965]: info: sendMpdCommand status took 8 milliseconds Feb 11 21:06:53 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand load "http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1" Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:53 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:53 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:53 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:53 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:53 volumio volumio[965]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 11 21:06:53 volumio volumio[965]: info: ------------------------------ 57ms Feb 11 21:06:53 volumio volumio[965]: info: ------------------------------ 59ms Feb 11 21:06:53 volumio volumio[965]: info: Feb 11 21:06:53 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:53 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:53 volumio volumio[965]: info: Feb 11 21:06:53 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:53 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:53 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:53 volumio volumio[965]: info: ------------------------------ 67ms Feb 11 21:06:53 volumio volumio[965]: info: sendMpdCommand playlistinfo took 63 milliseconds Feb 11 21:06:53 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:53 volumio volumio[965]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 11 21:06:53 volumio volumio[965]: info: ------------------------------ 94ms Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand add "http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1" Feb 11 21:06:55 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:55 volumio volumio[965]: error: updateQueue error: null Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 1077ms Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 1077ms Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:55 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand add "http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1" took 5 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand play Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:55 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces system playlist update Feb 11 21:06:55 volumio volumio[965]: info: Ignoring MPD Status Update Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 11ms Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand play took 8 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 8ms Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 5ms Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand status took 16 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand status took 15 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand status took 17 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand status took 4 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1","trackType":""} Feb 11 21:06:55 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus stop Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1","trackType":""} Feb 11 21:06:55 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:55 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 59ms Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 81ms Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:55 volumio volumio[965]: info: Feb 11 21:06:55 volumio volumio[965]: ---------------------------- MPD announces state update: player Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::getState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand status Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand playlistinfo took 66 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand playlistinfo took 65 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand status took 6 milliseconds Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1","trackType":""} Feb 11 21:06:55 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:55 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1","trackType":""} Feb 11 21:06:55 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:55 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 181ms Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 171ms Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand status took 116 milliseconds Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand playlistinfo took 112 milliseconds Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseState Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1","trackType":""} Feb 11 21:06:55 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:55 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 177ms Feb 11 21:06:55 volumio volumio[965]: info: sendMpdCommand playlistinfo took 58 milliseconds Feb 11 21:06:55 volumio volumio[965]: verbose: ControllerMpd::parseTrackInfo Feb 11 21:06:55 volumio volumio[965]: info: ControllerMpd::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::servicePushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"1","artist":null,"album":null,"uri":"http://usa6.fastcast4u.com/proxy/nhhqucow2?mp=/1","trackType":""} Feb 11 21:06:55 volumio volumio[965]: verbose: CURRENT POSITION 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState stateService play Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::syncState currentStatus play Feb 11 21:06:55 volumio volumio[965]: info: Received an update from plugin. extracting info from payload Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CorePlayQueue::getTrack 0 Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: CoreStateMachine::pushState Feb 11 21:06:55 volumio volumio[965]: info: CoreCommandRouter::volumioPushState Feb 11 21:06:55 volumio volumio[965]: info: ------------------------------ 221ms Feb 11 21:06:56 volumio volumio[965]: error: Search in plugin webradio timed out Feb 11 21:06:56 volumio volumio[965]: error: Search in plugin youtube2 timed out Feb 11 21:06:56 volumio volumio[965]: info: All search sources collected, pushing search results Feb 11 21:07:16 volumio volumio[965]: Searching all installed plugins Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: mpd , search Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: webradio , search Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: 80s80s , search Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: motherearthradio , search Feb 11 21:07:16 volumio volumio[965]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Feb 11 21:07:19 volumio volumio[965]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 21:07:19 volumio volumio[965]: Error: connect ETIMEDOUT 23.73.2.88:443 Feb 11 21:07:19 volumio volumio[965]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Feb 11 21:07:19 volumio volumio[965]: errno: -110, Feb 11 21:07:19 volumio volumio[965]: code: 'ETIMEDOUT', Feb 11 21:07:19 volumio volumio[965]: syscall: 'connect', Feb 11 21:07:19 volumio volumio[965]: address: '23.73.2.88', Feb 11 21:07:19 volumio volumio[965]: port: 443 Feb 11 21:07:19 volumio volumio[965]: } Feb 11 21:07:19 volumio volumio[965]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 11 21:07:20 volumio sudo[5948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-11 21:06 Feb 11 21:07:20 volumio sudo[5948]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"