Feb 25 00:08:02 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:02 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:02 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:02 volumio volumio[34353]: info: ------------------------------ 10215ms Feb 25 00:08:02 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" Feb 25 00:08:02 volumio volumio[34353]: info: ------------------------------ 10214ms Feb 25 00:08:02 volumio volumio[34353]: info: ------------------------------ 10213ms Feb 25 00:08:02 volumio volumio[34353]: info: sendMpdCommand stop took 6038 milliseconds Feb 25 00:08:02 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:02 volumio volumio[34353]: info: Feb 25 00:08:02 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:02 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:02 volumio volumio[34353]: info: Feb 25 00:08:02 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:02 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:02 volumio volumio[34353]: info: sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" took 1 milliseconds Feb 25 00:08:02 volumio volumio[34353]: info: sendMpdCommand clear took 1 milliseconds Feb 25 00:08:02 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:02 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:02 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" Feb 25 00:08:02 volumio volumio[34353]: info: Feb 25 00:08:02 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:02 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:02 volumio volumio[34353]: info: Feb 25 00:08:02 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:02 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:02 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:02 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:02 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:02 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:02 volumio volumio[34353]: info: sendMpdCommand play took 2 milliseconds Feb 25 00:08:06 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:06 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:06 volumio volumio[34353]: info: Adding Item to queue: http://live7.avf.ch:8000/urbn_main Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:06 volumio volumio[34353]: info: [1771967286535] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:06 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:06 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:06 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:06 volumio volumio[34353]: info: Adding Item to queue: http://live7.avf.ch:8000/urbn_main Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:06 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:06 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:06 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:06 volumio volumio[34353]: info: [1771967286693] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:06 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:10 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:10 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:10 volumio volumio[34353]: info: Adding Item to queue: https://mscp4.live-streams.nl:8142/lounge.ogg Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:10 volumio volumio[34353]: info: [1771967290546] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:10 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:10 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:10 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:10 volumio volumio[34353]: info: Adding Item to queue: https://mscp4.live-streams.nl:8142/lounge.ogg Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:10 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:10 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:10 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:10 volumio volumio[34353]: info: [1771967290697] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:10 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 10997ms Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 10997ms Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand stop took 7070 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand stop took 6912 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand stop took 3059 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand stop took 2908 milliseconds Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" took 4 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand clear took 2 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand clear took 2 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand clear took 2 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: sendMpdCommand clear took 2 milliseconds Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 1ms Feb 25 00:08:13 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "http://live7.avf.ch:8000/urbn_main" Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "http://live7.avf.ch:8000/urbn_main" Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "https://mscp4.live-streams.nl:8142/lounge.ogg" Feb 25 00:08:13 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "https://mscp4.live-streams.nl:8142/lounge.ogg" Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: info: Feb 25 00:08:13 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:13 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:13 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 25 00:08:16 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:16 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:16 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:16 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:16 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:16 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:16 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:16 volumio volumio[34353]: info: Adding Item to queue: https://streams.95bfm.com/stream112 Feb 25 00:08:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:16 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:16 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:16 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:16 volumio volumio[34353]: info: [1771967296684] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:17 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:17 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand play took 3476 milliseconds Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "http://live7.avf.ch:8000/urbn_main" Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "http://live7.avf.ch:8000/urbn_main" Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "https://mscp4.live-streams.nl:8142/lounge.ogg" Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "https://mscp4.live-streams.nl:8142/lounge.ogg" Feb 25 00:08:17 volumio volumio[34353]: info: ------------------------------ 3475ms Feb 25 00:08:17 volumio volumio[34353]: info: ------------------------------ 3474ms Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand stop took 400 milliseconds Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:17 volumio volumio[34353]: info: Feb 25 00:08:17 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:17 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:17 volumio volumio[34353]: info: Feb 25 00:08:17 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:17 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:17 volumio volumio[34353]: info: Feb 25 00:08:17 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:17 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand add "http://live7.avf.ch:8000/urbn_main" took 2 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand add "http://live7.avf.ch:8000/urbn_main" took 2 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand add "https://mscp4.live-streams.nl:8142/lounge.ogg" took 2 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand add "https://mscp4.live-streams.nl:8142/lounge.ogg" took 2 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand clear took 1 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:17 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:17 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:17 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:17 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "https://streams.95bfm.com/stream112" Feb 25 00:08:17 volumio volumio[34353]: info: Feb 25 00:08:17 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:17 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:17 volumio volumio[34353]: info: Feb 25 00:08:17 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:17 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:17 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:17 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:17 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:17 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:17 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:17 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand play took 3 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand play took 3 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand play took 3 milliseconds Feb 25 00:08:17 volumio volumio[34353]: info: sendMpdCommand play took 3 milliseconds Feb 25 00:08:19 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:19 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:19 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "https://streams.95bfm.com/stream112" Feb 25 00:08:19 volumio volumio[34353]: info: ------------------------------ 2285ms Feb 25 00:08:19 volumio volumio[34353]: info: ------------------------------ 2284ms Feb 25 00:08:19 volumio volumio[34353]: info: Feb 25 00:08:19 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:19 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:19 volumio volumio[34353]: info: Feb 25 00:08:19 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:19 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:19 volumio volumio[34353]: info: Feb 25 00:08:19 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:19 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:19 volumio volumio[34353]: info: sendMpdCommand add "https://streams.95bfm.com/stream112" took 4 milliseconds Feb 25 00:08:19 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:19 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:19 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:19 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:19 volumio volumio[34353]: info: Feb 25 00:08:19 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:19 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:19 volumio volumio[34353]: info: Feb 25 00:08:19 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:19 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:19 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:19 volumio volumio[34353]: info: sendMpdCommand play took 3 milliseconds Feb 25 00:08:19 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:19 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:08:21 volumio volumio[34353]: info: Feb 25 00:08:21 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:21 volumio volumio[34353]: info: Feb 25 00:08:21 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:21 volumio volumio[34353]: info: Feb 25 00:08:21 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:21 volumio volumio[34353]: info: Feb 25 00:08:21 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand status took 22 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand status took 20 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:21 volumio volumio[34353]: info: Feb 25 00:08:21 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand status took 21 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand status took 2 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":null,"album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:21 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus stop Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":null,"album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:21 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:21 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: ------------------------------ 29ms Feb 25 00:08:21 volumio volumio[34353]: info: ------------------------------ 30ms Feb 25 00:08:21 volumio volumio[34353]: info: Feb 25 00:08:21 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand status took 10 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand status took 1 milliseconds Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":null,"album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:21 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:21 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":null,"album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:21 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:21 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: ------------------------------ 59ms Feb 25 00:08:21 volumio volumio[34353]: info: ------------------------------ 40ms Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 39 milliseconds Feb 25 00:08:21 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 38 milliseconds Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:21 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":null,"album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:21 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:21 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":null,"album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:21 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:21 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:21 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:21 volumio volumio[34353]: info: ------------------------------ 67ms Feb 25 00:08:21 volumio volumio[34353]: info: ------------------------------ 59ms Feb 25 00:08:22 volumio volumio[34353]: info: Feb 25 00:08:22 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:22 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:22 volumio volumio[34353]: info: Feb 25 00:08:22 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:22 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:22 volumio volumio[34353]: info: Feb 25 00:08:22 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:22 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:22 volumio volumio[34353]: info: Feb 25 00:08:22 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:22 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:22 volumio volumio[34353]: info: Feb 25 00:08:22 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:22 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:22 volumio volumio[34353]: info: Feb 25 00:08:22 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:22 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:22 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:22 volumio volumio[34353]: info: sendMpdCommand status took 2 milliseconds Feb 25 00:08:22 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:22 volumio volumio[34353]: info: sendMpdCommand status took 4 milliseconds Feb 25 00:08:22 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:08:22 volumio volumio[34353]: info: sendMpdCommand status took 4 milliseconds Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:22 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:08:22 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 25 00:08:22 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:22 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:22 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":964,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":"95bFM Flac","album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:22 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:22 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:22 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":964,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":"95bFM Flac","album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:22 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:22 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:22 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":964,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream112","artist":"95bFM Flac","album":null,"uri":"https://streams.95bfm.com/stream112","trackType":""} Feb 25 00:08:22 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:22 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:22 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:22 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:22 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:22 volumio volumio[34353]: info: ------------------------------ 25ms Feb 25 00:08:22 volumio volumio[34353]: info: ------------------------------ 26ms Feb 25 00:08:22 volumio volumio[34353]: info: ------------------------------ 26ms Feb 25 00:08:39 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::stPlaybackTimer Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::serviceStop Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::serviceStop Feb 25 00:08:39 volumio volumio[34353]: info: [1771967319166] ControllerWebradio::stop Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:39 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:39 volumio volumio[34353]: info: Adding Item to queue: http://choco.hostingradio.ru:10010/fm Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: [1771967319177] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand stop took 15 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand stop took 6 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 3 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand clear took 2 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 1 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 1 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "http://choco.hostingradio.ru:10010/fm" Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 12ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 11ms Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:39 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:39 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 155ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 154 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "http://choco.hostingradio.ru:10010/fm" Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 144ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 144ms Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 159ms Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand add "http://choco.hostingradio.ru:10010/fm" took 2 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand play took 1 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 1ms Feb 25 00:08:39 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:39 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:39 volumio volumio[34353]: info: Adding Item to queue: http://choco.hostingradio.ru:10010/fm Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: [1771967319363] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand stop took 2 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 1 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand clear took 1 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "http://choco.hostingradio.ru:10010/fm" Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "http://choco.hostingradio.ru:10010/fm" Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 73 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 73 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 78ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 79ms Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand add "http://choco.hostingradio.ru:10010/fm" took 7 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 6ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 6ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 5ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand play took 5 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 7ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 6ms Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 16 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 15 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 15 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 3 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: 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":"fm","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus stop Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: 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":"fm","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: 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":"fm","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 28ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 33ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 34ms Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 21 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 1 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: 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":"fm","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 36ms Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 27 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 27 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: 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":"Cassandre - Dark Horse (by Katy Perry)","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 51ms Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:39 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:39 volumio volumio[34353]: info: Feb 25 00:08:39 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 28ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 28 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 27 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 8ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 7 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: 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":"Cassandre - Dark Horse (by Katy Perry)","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 71ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand status took 26 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Cassandre - Dark Horse (by Katy Perry)","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Cassandre - Dark Horse (by Katy Perry)","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 74ms Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 53ms Feb 25 00:08:39 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 25 00:08:39 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:39 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:39 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:39 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":858,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Cassandre - Dark Horse (by Katy Perry)","artist":null,"album":null,"uri":"http://choco.hostingradio.ru:10010/fm","trackType":""} Feb 25 00:08:39 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:08:39 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:39 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:39 volumio volumio[34353]: info: ------------------------------ 58ms Feb 25 00:08:44 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::stPlaybackTimer Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::serviceStop Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::serviceStop Feb 25 00:08:44 volumio volumio[34353]: info: [1771967324612] ControllerWebradio::stop Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:44 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:44 volumio volumio[34353]: info: Adding Item to queue: https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: [1771967324621] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:44 volumio volumio[34353]: info: Feb 25 00:08:44 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:44 volumio volumio[34353]: info: sendMpdCommand stop took 13 milliseconds Feb 25 00:08:44 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:44 volumio volumio[34353]: info: sendMpdCommand stop took 3 milliseconds Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:44 volumio volumio[34353]: info: Feb 25 00:08:44 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:44 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:44 volumio volumio[34353]: info: Feb 25 00:08:44 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:08:44 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:08:44 volumio volumio[34353]: info: Feb 25 00:08:44 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:44 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:44 volumio volumio[34353]: info: sendMpdCommand status took 3 milliseconds Feb 25 00:08:44 volumio volumio[34353]: info: sendMpdCommand clear took 2 milliseconds Feb 25 00:08:44 volumio volumio[34353]: info: sendMpdCommand status took 2 milliseconds Feb 25 00:08:44 volumio volumio[34353]: info: sendMpdCommand status took 2 milliseconds Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:08:44 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 25 00:08:44 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 25 00:08:44 volumio volumio[34353]: info: ------------------------------ 10ms Feb 25 00:08:44 volumio volumio[34353]: info: ------------------------------ 9ms Feb 25 00:08:44 volumio volumio[34353]: info: Feb 25 00:08:44 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:44 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:44 volumio volumio[34353]: info: Feb 25 00:08:44 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:44 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:44 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:08:44 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:08:44 volumio volumio[34353]: info: Adding Item to queue: https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:08:44 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:08:44 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:08:44 volumio volumio[34353]: info: [1771967324773] ControllerWebradio::clearAddPlayTrack Feb 25 00:08:44 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:08:50 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , removeMyWebRadio Feb 25 00:08:50 volumio volumio[34353]: info: {"name":"IcECaast"} Feb 25 00:08:50 volumio volumio[34353]: info: Saving local item my-web-radio Feb 25 00:08:50 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 25 00:08:55 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 10977ms Feb 25 00:08:55 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 10977 milliseconds Feb 25 00:08:55 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" Feb 25 00:08:55 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:08:55 volumio volumio[34353]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 10981ms Feb 25 00:08:55 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:55 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:55 volumio volumio[34353]: info: Feb 25 00:08:55 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:55 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 10971ms Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 10970ms Feb 25 00:08:55 volumio volumio[34353]: info: sendMpdCommand stop took 10834 milliseconds Feb 25 00:08:55 volumio volumio[34353]: info: sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" took 1 milliseconds Feb 25 00:08:55 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:08:55 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:08:55 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:08:55 volumio volumio[34353]: info: Feb 25 00:08:55 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:55 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:55 volumio volumio[34353]: info: Feb 25 00:08:55 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:55 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:55 volumio volumio[34353]: info: Feb 25 00:08:55 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:55 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:55 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:55 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:08:55 volumio volumio[34353]: info: sendMpdCommand clear took 2 milliseconds Feb 25 00:08:55 volumio volumio[34353]: info: sendMpdCommand play took 1 milliseconds Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 1ms Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 1ms Feb 25 00:08:55 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" Feb 25 00:08:55 volumio volumio[34353]: info: Feb 25 00:08:55 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:55 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:55 volumio volumio[34353]: info: Feb 25 00:08:55 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:08:55 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:08:55 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:08:55 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:09:06 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" Feb 25 00:09:06 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:09:06 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:09:06 volumio volumio[34353]: info: ------------------------------ 10994ms Feb 25 00:09:06 volumio volumio[34353]: info: ------------------------------ 10995ms Feb 25 00:09:06 volumio volumio[34353]: info: Feb 25 00:09:06 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:06 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:06 volumio volumio[34353]: info: sendMpdCommand add "https://stream10.xdevel.com/audio15s976748-2280/stream/icecast.audio" took 1 milliseconds Feb 25 00:09:06 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:09:06 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:09:06 volumio volumio[34353]: info: Feb 25 00:09:06 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:06 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:06 volumio volumio[34353]: info: Feb 25 00:09:06 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:06 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:06 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:09:06 volumio volumio[34353]: info: sendMpdCommand play took 3 milliseconds Feb 25 00:09:06 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:09:06 volumio volumio[34353]: info: ------------------------------ 1ms Feb 25 00:09:10 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , addMyWebRadio Feb 25 00:09:10 volumio volumio[34353]: info: {"name":"calamarrradio","uri":"http://www.calamarrradio.org:8000/stream"} Feb 25 00:09:10 volumio volumio[34353]: info: Saving local item my-web-radio Feb 25 00:09:11 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 25 00:09:11 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:09:14 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:09:14 volumio volumio[34353]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::ClearQueue Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:09:14 volumio volumio[34353]: info: CorePlayQueue::clearPlayQueue Feb 25 00:09:14 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:09:14 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::addQueueItems Feb 25 00:09:14 volumio volumio[34353]: info: CorePlayQueue::addQueueItems Feb 25 00:09:14 volumio volumio[34353]: info: Preload queue cleared Feb 25 00:09:14 volumio volumio[34353]: info: Adding Item to queue: http://www.calamarrradio.org:8000/stream Feb 25 00:09:14 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 25 00:09:14 volumio volumio[34353]: info: CoreCommandRouter::volumioPushQueue Feb 25 00:09:14 volumio volumio[34353]: info: CorePlayQueue::saveQueue Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::updateTrackBlock Feb 25 00:09:14 volumio volumio[34353]: info: CorePlayQueue::getTrackBlock Feb 25 00:09:14 volumio volumio[34353]: info: CoreCommandRouter::volumioPlay Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::play index 0 Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::stop Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::play index undefined Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 25 00:09:14 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:14 volumio volumio[34353]: info: CoreStateMachine::startPlaybackTimer Feb 25 00:09:14 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:14 volumio volumio[34353]: info: [1771967354078] ControllerWebradio::clearAddPlayTrack Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand stop Feb 25 00:09:14 volumio volumio[34353]: info: Feb 25 00:09:14 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:14 volumio volumio[34353]: info: sendMpdCommand stop took 9 milliseconds Feb 25 00:09:14 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand clear Feb 25 00:09:14 volumio volumio[34353]: info: Feb 25 00:09:14 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:14 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:14 volumio volumio[34353]: info: sendMpdCommand status took 1 milliseconds Feb 25 00:09:14 volumio volumio[34353]: info: sendMpdCommand clear took 1 milliseconds Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand load "http://www.calamarrradio.org:8000/stream" Feb 25 00:09:14 volumio volumio[34353]: info: Feb 25 00:09:14 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:14 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:14 volumio volumio[34353]: info: Feb 25 00:09:14 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:14 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:14 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:15 volumio volumio[34353]: error: updateQueue error: null Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 1049ms Feb 25 00:09:15 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 1050 milliseconds Feb 25 00:09:15 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand add "http://www.calamarrradio.org:8000/stream" Feb 25 00:09:15 volumio volumio[34353]: info: sendMpdCommand status took 1049 milliseconds Feb 25 00:09:15 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:15 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:15 volumio volumio[34353]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Feb 25 00:09:15 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:15 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:15 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:15 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:15 volumio volumio[34353]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 1054ms Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 1058ms Feb 25 00:09:15 volumio volumio[34353]: info: Feb 25 00:09:15 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:15 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:15 volumio volumio[34353]: info: Feb 25 00:09:15 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:15 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:15 volumio volumio[34353]: info: sendMpdCommand status took 1058 milliseconds Feb 25 00:09:15 volumio volumio[34353]: info: sendMpdCommand add "http://www.calamarrradio.org:8000/stream" took 11 milliseconds Feb 25 00:09:15 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:15 volumio volumio[34353]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 25 00:09:15 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand play Feb 25 00:09:15 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:15 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:15 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:15 volumio volumio[34353]: 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 25 00:09:15 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:15 volumio volumio[34353]: info: CoreStateMachine::syncState stateService stop Feb 25 00:09:15 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus stop Feb 25 00:09:15 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:15 volumio volumio[34353]: info: No code Feb 25 00:09:15 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:15 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 1068ms Feb 25 00:09:15 volumio volumio[34353]: info: Feb 25 00:09:15 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:15 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 14ms Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 15ms Feb 25 00:09:15 volumio volumio[34353]: info: sendMpdCommand play took 14 milliseconds Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:09:15 volumio volumio[34353]: info: Feb 25 00:09:15 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:15 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:15 volumio volumio[34353]: info: Feb 25 00:09:15 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:15 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:09:15 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 15 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 14 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 14 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 3 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 1 milliseconds Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus stop Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 23ms Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 34ms Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 33ms Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 18 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 39ms Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 41ms Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 35 milliseconds Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 70ms Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:16 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:16 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces system playlist update Feb 25 00:09:16 volumio volumio[34353]: info: Ignoring MPD Status Update Feb 25 00:09:16 volumio volumio[34353]: info: Feb 25 00:09:16 volumio volumio[34353]: ---------------------------- MPD announces state update: player Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::getState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand status Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 4ms Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 4 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 3ms Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 3 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 2ms Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand status took 2 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 1 milliseconds Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseState Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Depuis l'automne","artist":"Harmonium","album":"Si on avait besoin d'une cinquième saison","uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 13ms Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 25 00:09:16 volumio volumio[34353]: info: sendMpdCommand playlistinfo took 8 milliseconds Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: verbose: ControllerMpd::parseTrackInfo Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":964,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Depuis l'automne","artist":"Harmonium","album":"Si on avait besoin d'une cinquième saison","uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ControllerMpd::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::servicePushState Feb 25 00:09:16 volumio volumio[34353]: info: CorePlayQueue::getTrack 0 Feb 25 00:09:16 volumio volumio[34353]: verbose: STATE SERVICE {"status":"play","position":0,"seek":964,"duration":0,"samplerate":"48 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Depuis l'automne","artist":"Harmonium","album":"Si on avait besoin d'une cinquième saison","uri":"http://www.calamarrradio.org:8000/stream","trackType":""} Feb 25 00:09:16 volumio volumio[34353]: verbose: CURRENT POSITION 0 Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState stateService play Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::syncState currentStatus play Feb 25 00:09:16 volumio volumio[34353]: info: Received an update from plugin. extracting info from payload Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:16 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 32ms Feb 25 00:09:16 volumio volumio[34353]: info: ------------------------------ 30ms Feb 25 00:09:18 volumio volumio[34353]: info: VolumeController::SetAlsaVolume35 Feb 25 00:09:18 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:18 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:18 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:19 volumio volumio[34353]: info: VolumeController::SetAlsaVolume45 Feb 25 00:09:19 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:19 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:19 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:21 volumio volumio[34353]: info: VolumeController::SetAlsaVolume40 Feb 25 00:09:21 volumio volumio[34353]: info: CoreStateMachine::pushState Feb 25 00:09:21 volumio volumio[34353]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 00:09:21 volumio volumio[34353]: info: CoreCommandRouter::volumioPushState Feb 25 00:09:25 volumio volumio[34353]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 00:09:25 volumio volumio[34353]: Error: read ECONNRESET Feb 25 00:09:25 volumio volumio[34353]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:217:20) { Feb 25 00:09:25 volumio volumio[34353]: errno: -104, Feb 25 00:09:25 volumio volumio[34353]: code: 'ECONNRESET', Feb 25 00:09:25 volumio volumio[34353]: syscall: 'read' Feb 25 00:09:25 volumio volumio[34353]: } Feb 25 00:09:25 volumio volumio[34353]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 00:09:26 volumio sudo[46552]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 00:08' Feb 25 00:09:26 volumio sudo[46552]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"