-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Thu 2024-08-29 04:36:13 UTC. -- Aug 29 04:35:22 volumio ntpd[617]: 193.182.111.14 local addr 192.168.110.127 -> Aug 29 04:35:32 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 29 04:35:36 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 29 04:35:36 volumio volumio[674]: info: Getting webradio selection Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::ClearQueue Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:39 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::stPlaybackTimer Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::updateTrackBlock Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::getTrackBlock Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::serviceStop Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::serviceStop Aug 29 04:35:39 volumio volumio[674]: info: ControllerMpd::stop Aug 29 04:35:39 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::clearPlayQueue Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::addQueueItems Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::addQueueItems Aug 29 04:35:39 volumio volumio[674]: info: Adding Item to queue: http://stream.absolutradio.de/hq/mp3-160/radioplayer/ Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::updateTrackBlock Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::getTrackBlock Aug 29 04:35:39 volumio volumio[674]: info: CoreCommandRouter::volumioPlay Aug 29 04:35:39 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::play index 0 Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:39 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::play index undefined Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:39 volumio volumio[674]: info: CoreStateMachine::startPlaybackTimer Aug 29 04:35:39 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:39 volumio volumio[674]: info: [1724906139029] ControllerWebradio::clearAddPlayTrack Aug 29 04:35:39 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:35:39 volumio volumio[674]: info: sendMpdCommand stop took 18 milliseconds Aug 29 04:35:39 volumio volumio[674]: info: sendMpdCommand stop took 4 milliseconds Aug 29 04:35:39 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 04:35:39 volumio volumio[674]: info: Aug 29 04:35:39 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:39 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:39 volumio volumio[674]: info: sendMpdCommand clear took 2 milliseconds Aug 29 04:35:39 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand load "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:39 volumio volumio[674]: info: Aug 29 04:35:39 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:39 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:39 volumio volumio[674]: error: updateQueue error: null Aug 29 04:35:39 volumio volumio[674]: info: ------------------------------ 4ms Aug 29 04:35:40 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:40 volumio volumio[674]: error: updateQueue error: null Aug 29 04:35:40 volumio volumio[674]: info: Aug 29 04:35:40 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:40 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:40 volumio volumio[674]: info: ------------------------------ 1191ms Aug 29 04:35:40 volumio volumio[674]: info: sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" took 2 milliseconds Aug 29 04:35:40 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 04:35:40 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand play Aug 29 04:35:40 volumio volumio[674]: info: Aug 29 04:35:40 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:40 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:40 volumio volumio[674]: info: ------------------------------ 4ms Aug 29 04:35:40 volumio volumio[674]: info: sendMpdCommand play took 3 milliseconds Aug 29 04:35:40 volumio volumio[674]: info: ------------------------------ 2ms Aug 29 04:35:41 volumio volumio[674]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::ClearQueue Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:41 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:41 volumio volumio[674]: info: CorePlayQueue::clearPlayQueue Aug 29 04:35:41 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:35:41 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:41 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::addQueueItems Aug 29 04:35:41 volumio volumio[674]: info: CorePlayQueue::addQueueItems Aug 29 04:35:41 volumio volumio[674]: info: Adding Item to queue: http://stream.absolutradio.de/hq/mp3-160/radioplayer/ Aug 29 04:35:41 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 29 04:35:41 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:35:41 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::updateTrackBlock Aug 29 04:35:41 volumio volumio[674]: info: CorePlayQueue::getTrackBlock Aug 29 04:35:41 volumio volumio[674]: info: CoreCommandRouter::volumioPlay Aug 29 04:35:41 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::play index 0 Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:41 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::play index undefined Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:41 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:41 volumio volumio[674]: info: CoreStateMachine::startPlaybackTimer Aug 29 04:35:41 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:41 volumio volumio[674]: info: [1724906141174] ControllerWebradio::clearAddPlayTrack Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:35:41 volumio volumio[674]: info: Aug 29 04:35:41 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:41 volumio volumio[674]: info: sendMpdCommand stop took 300 milliseconds Aug 29 04:35:41 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 04:35:41 volumio volumio[674]: info: Aug 29 04:35:41 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:41 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:41 volumio volumio[674]: info: sendMpdCommand status took 2 milliseconds Aug 29 04:35:41 volumio volumio[674]: info: sendMpdCommand clear took 2 milliseconds Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand load "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:41 volumio volumio[674]: info: Aug 29 04:35:41 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:41 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:41 volumio volumio[674]: error: updateQueue error: null Aug 29 04:35:41 volumio volumio[674]: info: ------------------------------ 5ms Aug 29 04:35:41 volumio volumio[674]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 29 04:35:41 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:35:41 volumio volumio[674]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 29 04:35:41 volumio volumio[674]: info: ------------------------------ 9ms Aug 29 04:35:42 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:42 volumio volumio[674]: info: Aug 29 04:35:42 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:42 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:42 volumio volumio[674]: info: sendMpdCommand status took 1273 milliseconds Aug 29 04:35:42 volumio volumio[674]: info: sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" took 1 milliseconds Aug 29 04:35:42 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 04:35:42 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand play Aug 29 04:35:42 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:42 volumio volumio[674]: 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} Aug 29 04:35:42 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::syncState stateService stop Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:42 volumio volumio[674]: info: No code Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:42 volumio volumio[674]: info: ------------------------------ 1288ms Aug 29 04:35:42 volumio volumio[674]: info: Aug 29 04:35:42 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:42 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:42 volumio volumio[674]: info: ------------------------------ 16ms Aug 29 04:35:42 volumio volumio[674]: info: sendMpdCommand play took 15 milliseconds Aug 29 04:35:42 volumio volumio[674]: info: ------------------------------ 2ms Aug 29 04:35:42 volumio volumio[674]: info: Aug 29 04:35:42 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:42 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:42 volumio volumio[674]: info: ------------------------------ 4ms Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::ClearQueue Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:42 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::clearPlayQueue Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::addQueueItems Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::addQueueItems Aug 29 04:35:42 volumio volumio[674]: info: Adding Item to queue: http://stream.absolutradio.de/hq/mp3-160/radioplayer/ Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::updateTrackBlock Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::getTrackBlock Aug 29 04:35:42 volumio volumio[674]: info: CoreCommandRouter::volumioPlay Aug 29 04:35:42 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::play index 0 Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:42 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::play index undefined Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:42 volumio volumio[674]: info: CoreStateMachine::startPlaybackTimer Aug 29 04:35:42 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:42 volumio volumio[674]: info: [1724906142950] ControllerWebradio::clearAddPlayTrack Aug 29 04:35:42 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:35:43 volumio volumio[674]: info: Aug 29 04:35:43 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:43 volumio volumio[674]: info: sendMpdCommand stop took 642 milliseconds Aug 29 04:35:43 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:43 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:43 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 04:35:43 volumio volumio[674]: info: Aug 29 04:35:43 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:43 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:43 volumio volumio[674]: info: sendMpdCommand status took 1 milliseconds Aug 29 04:35:43 volumio volumio[674]: info: sendMpdCommand clear took 1 milliseconds Aug 29 04:35:43 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:43 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:35:43 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand load "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:43 volumio volumio[674]: info: Aug 29 04:35:43 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:43 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:43 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:43 volumio volumio[674]: error: updateQueue error: null Aug 29 04:35:43 volumio volumio[674]: info: ------------------------------ 4ms Aug 29 04:35:43 volumio volumio[674]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 04:35:43 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:35:43 volumio volumio[674]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 29 04:35:43 volumio volumio[674]: info: ------------------------------ 6ms Aug 29 04:35:44 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:44 volumio volumio[674]: info: Aug 29 04:35:44 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:44 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:44 volumio volumio[674]: info: sendMpdCommand status took 946 milliseconds Aug 29 04:35:44 volumio volumio[674]: info: sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" took 2 milliseconds Aug 29 04:35:44 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:44 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 04:35:44 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand play Aug 29 04:35:44 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:35:44 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:35:44 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:44 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:35:44 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:44 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:44 volumio volumio[674]: 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} Aug 29 04:35:44 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:35:44 volumio volumio[674]: info: CoreStateMachine::syncState stateService stop Aug 29 04:35:44 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:35:44 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:44 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:44 volumio volumio[674]: info: No code Aug 29 04:35:44 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:44 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:44 volumio volumio[674]: info: ------------------------------ 967ms Aug 29 04:35:44 volumio volumio[674]: info: Aug 29 04:35:44 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:44 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:44 volumio volumio[674]: info: ------------------------------ 25ms Aug 29 04:35:44 volumio volumio[674]: info: sendMpdCommand play took 24 milliseconds Aug 29 04:35:44 volumio volumio[674]: info: ------------------------------ 5ms Aug 29 04:35:44 volumio volumio[674]: info: Aug 29 04:35:44 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:44 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:44 volumio volumio[674]: info: ------------------------------ 5ms Aug 29 04:35:45 volumio volumio[674]: info: Aug 29 04:35:45 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:45 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:45 volumio volumio[674]: info: Aug 29 04:35:45 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:45 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 29 04:35:45 volumio volumio[674]: info: sendMpdCommand status took 5 milliseconds Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 29 04:35:45 volumio volumio[674]: info: sendMpdCommand status took 5 milliseconds Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:35:45 volumio volumio[674]: info: sendMpdCommand clearerror took 5 milliseconds Aug 29 04:35:45 volumio volumio[674]: info: sendMpdCommand clearerror took 4 milliseconds Aug 29 04:35:45 volumio volumio[674]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 04:35:45 volumio volumio[674]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:35:45 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:35:45 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:45 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:45 volumio volumio[674]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://stream.absolutradio.de/hq/mp3-160/radioplayer/","trackType":""} Aug 29 04:35:45 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::syncState stateService stop Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:45 volumio volumio[674]: info: No code Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:45 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:45 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:45 volumio volumio[674]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://stream.absolutradio.de/hq/mp3-160/radioplayer/","trackType":""} Aug 29 04:35:45 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::syncState stateService stop Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:45 volumio volumio[674]: info: No code Aug 29 04:35:45 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:45 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:45 volumio volumio[674]: info: ------------------------------ 33ms Aug 29 04:35:45 volumio volumio[674]: info: ------------------------------ 33ms Aug 29 04:35:51 volumio volumio[674]: info: CoreCommandRouter::volumioPlay Aug 29 04:35:51 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:35:51 volumio volumio[674]: info: CoreStateMachine::play index undefined Aug 29 04:35:51 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:35:51 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:51 volumio volumio[674]: info: CoreStateMachine::startPlaybackTimer Aug 29 04:35:51 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:51 volumio volumio[674]: info: [1724906151683] ControllerWebradio::clearAddPlayTrack Aug 29 04:35:51 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:35:51 volumio volumio[674]: info: sendMpdCommand stop took 1 milliseconds Aug 29 04:35:51 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 04:35:51 volumio volumio[674]: info: Aug 29 04:35:51 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:51 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:51 volumio volumio[674]: info: sendMpdCommand clear took 1 milliseconds Aug 29 04:35:51 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand load "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:51 volumio volumio[674]: info: Aug 29 04:35:51 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:51 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:51 volumio volumio[674]: error: updateQueue error: null Aug 29 04:35:51 volumio volumio[674]: info: ------------------------------ 3ms Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" Aug 29 04:35:52 volumio volumio[674]: error: updateQueue error: null Aug 29 04:35:52 volumio volumio[674]: info: Aug 29 04:35:52 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:52 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:52 volumio volumio[674]: info: ------------------------------ 827ms Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand add "http://stream.absolutradio.de/hq/mp3-160/radioplayer/" took 1 milliseconds Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand play Aug 29 04:35:52 volumio volumio[674]: info: Aug 29 04:35:52 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:35:52 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:35:52 volumio volumio[674]: info: ------------------------------ 3ms Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand play took 2 milliseconds Aug 29 04:35:52 volumio volumio[674]: info: ------------------------------ 2ms Aug 29 04:35:52 volumio volumio[674]: info: Aug 29 04:35:52 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:52 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:52 volumio volumio[674]: info: Aug 29 04:35:52 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:35:52 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand status took 5 milliseconds Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clearerror Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand status took 8 milliseconds Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand clearerror took 5 milliseconds Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand clearerror took 3 milliseconds Aug 29 04:35:52 volumio volumio[674]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:35:52 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:35:52 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:52 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:52 volumio volumio[674]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://stream.absolutradio.de/hq/mp3-160/radioplayer/","trackType":""} Aug 29 04:35:52 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::syncState stateService stop Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:52 volumio volumio[674]: info: No code Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:52 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:52 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:35:52 volumio volumio[674]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://stream.absolutradio.de/hq/mp3-160/radioplayer/","trackType":""} Aug 29 04:35:52 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::syncState stateService stop Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:52 volumio volumio[674]: info: No code Aug 29 04:35:52 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:35:52 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:35:52 volumio volumio[674]: info: ------------------------------ 36ms Aug 29 04:35:52 volumio volumio[674]: info: ------------------------------ 36ms Aug 29 04:36:01 volumio ntpd[617]: 162.159.200.123 local addr 192.168.110.127 -> Aug 29 04:36:04 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Aug 29 04:36:08 volumio volumio[674]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::ClearQueue Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:08 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:36:08 volumio volumio[674]: info: CorePlayQueue::clearPlayQueue Aug 29 04:36:08 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:36:08 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:08 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::addQueueItems Aug 29 04:36:08 volumio volumio[674]: info: CorePlayQueue::addQueueItems Aug 29 04:36:08 volumio volumio[674]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Aug 29 04:36:08 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 29 04:36:08 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:36:08 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::updateTrackBlock Aug 29 04:36:08 volumio volumio[674]: info: CorePlayQueue::getTrackBlock Aug 29 04:36:08 volumio volumio[674]: info: CoreCommandRouter::volumioPlay Aug 29 04:36:08 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::play index 0 Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:08 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::play index undefined Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:08 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:08 volumio volumio[674]: info: CoreStateMachine::startPlaybackTimer Aug 29 04:36:08 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:08 volumio volumio[674]: info: [1724906168797] ControllerWebradio::clearAddPlayTrack Aug 29 04:36:08 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:36:08 volumio volumio[674]: info: sendMpdCommand stop took 3 milliseconds Aug 29 04:36:08 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 04:36:08 volumio volumio[674]: info: Aug 29 04:36:08 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:08 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:08 volumio volumio[674]: info: sendMpdCommand clear took 1 milliseconds Aug 29 04:36:08 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Aug 29 04:36:08 volumio volumio[674]: info: Aug 29 04:36:08 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:08 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:08 volumio volumio[674]: error: updateQueue error: null Aug 29 04:36:08 volumio volumio[674]: info: ------------------------------ 5ms Aug 29 04:36:09 volumio volumio[674]: info: Aug 29 04:36:09 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:09 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:09 volumio volumio[674]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 522 milliseconds Aug 29 04:36:09 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 04:36:09 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand play Aug 29 04:36:09 volumio volumio[674]: info: ------------------------------ 524ms Aug 29 04:36:09 volumio volumio[674]: info: ------------------------------ 3ms Aug 29 04:36:09 volumio volumio[674]: info: sendMpdCommand play took 2 milliseconds Aug 29 04:36:09 volumio volumio[674]: info: Aug 29 04:36:09 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:09 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:09 volumio volumio[674]: info: ------------------------------ 4ms Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 3 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 2 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 3 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10179/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:11 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10179/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:11 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:11 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 26ms Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 24ms Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand playlistinfo took 21 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 1 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10179/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:11 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:11 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 35ms Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand playlistinfo took 13 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10179/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:11 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:11 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 24ms Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:11 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:11 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 6ms Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 2 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 2ms Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 1 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Michael Schulte, R3HAB - Better Me","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:11 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:11 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: verbose: STATE SERVICE {"status":"play","position":0,"seek":886,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Michael Schulte, R3HAB - Better Me","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:11 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:11 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 24ms Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 23ms Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::ClearQueue Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:11 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::stPlaybackTimer Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::updateTrackBlock Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrackBlock Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::serviceStop Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::serviceStop Aug 29 04:36:11 volumio volumio[674]: info: [1724906171637] ControllerWebradio::stop Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::clearPlayQueue Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::addQueueItems Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::addQueueItems Aug 29 04:36:11 volumio volumio[674]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::saveQueue Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushQueue Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::updateTrackBlock Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrackBlock Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPlay Aug 29 04:36:11 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::play index 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::stop Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:11 volumio volumio[674]: verbose: UNSET VOLATILE Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::play index undefined Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::startPlaybackTimer Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: [1724906171649] ControllerWebradio::clearAddPlayTrack Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand stop Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand stop took 17 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand stop took 4 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand clear Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:11 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 18 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand clear took 17 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand status took 16 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:11 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:36:11 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:11 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:11 volumio volumio[674]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 24ms Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:11 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:11 volumio volumio[674]: error: updateQueue error: null Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 10ms Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:11 volumio volumio[674]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 28ms Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 223 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 29 04:36:11 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand play Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:11 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 219ms Aug 29 04:36:11 volumio volumio[674]: info: sendMpdCommand play took 2 milliseconds Aug 29 04:36:11 volumio volumio[674]: info: Aug 29 04:36:11 volumio volumio[674]: ---------------------------- MPD announces system playlist update Aug 29 04:36:11 volumio volumio[674]: info: Ignoring MPD Status Update Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 2ms Aug 29 04:36:11 volumio volumio[674]: info: ------------------------------ 1ms Aug 29 04:36:13 volumio volumio[674]: info: Aug 29 04:36:13 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:13 volumio volumio[674]: info: Aug 29 04:36:13 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:13 volumio volumio[674]: info: Aug 29 04:36:13 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand status took 2 milliseconds Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand status took 7 milliseconds Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:13 volumio volumio[674]: info: Aug 29 04:36:13 volumio volumio[674]: ---------------------------- MPD announces state update: player Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::getState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand status Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand status took 3 milliseconds Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand playlistinfo took 3 milliseconds Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand status took 2 milliseconds Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseState Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:13 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:13 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10267/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:13 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus stop Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:13 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:13 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10267/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:13 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:13 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:13 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:13 volumio volumio[674]: info: ------------------------------ 30ms Aug 29 04:36:13 volumio volumio[674]: info: ------------------------------ 29ms Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand playlistinfo took 18 milliseconds Aug 29 04:36:13 volumio volumio[674]: info: sendMpdCommand playlistinfo took 17 milliseconds Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:13 volumio volumio[674]: verbose: ControllerMpd::parseTrackInfo Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:13 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:13 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10267/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:13 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:13 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:13 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:13 volumio volumio[674]: info: ControllerMpd::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::servicePushState Aug 29 04:36:13 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:13 volumio volumio[674]: 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":"antenne","artist":"(#1 - 10267/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Aug 29 04:36:13 volumio volumio[674]: verbose: CURRENT POSITION 0 Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState stateService play Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::syncState currentStatus play Aug 29 04:36:13 volumio volumio[674]: info: Received an update from plugin. extracting info from payload Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:13 volumio volumio[674]: info: CorePlayQueue::getTrack 0 Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:13 volumio volumio[674]: info: CoreStateMachine::pushState Aug 29 04:36:13 volumio volumio[674]: info: CoreCommandRouter::volumioPushState Aug 29 04:36:13 volumio volumio[674]: info: ------------------------------ 45ms Aug 29 04:36:13 volumio volumio[674]: info: ------------------------------ 36ms Aug 29 04:36:13 volumio volumio[674]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 04:36:13 volumio volumio[674]: Error: connect ETIMEDOUT 74.86.228.110:80 Aug 29 04:36:13 volumio volumio[674]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Aug 29 04:36:13 volumio volumio[674]: errno: -110, Aug 29 04:36:13 volumio volumio[674]: code: 'ETIMEDOUT', Aug 29 04:36:13 volumio volumio[674]: syscall: 'connect', Aug 29 04:36:13 volumio volumio[674]: address: '74.86.228.110', Aug 29 04:36:13 volumio volumio[674]: port: 80 Aug 29 04:36:13 volumio volumio[674]: } Aug 29 04:36:13 volumio volumio[674]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 29 04:36:13 volumio sudo[2776]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-29 04:35 Aug 29 04:36:13 volumio sudo[2776]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="9eadfb08439e8c37bef9a38c0641d736c1391e0c" VOLUMIO_FE_VERSION="e6f7875b0e497e33187ca2553d7998c4aeb06af9" VOLUMIO_FE3_VERSION="8d9f9503eeacae3e8f349def90b368b32462d83b" VOLUMIO_BE_VERSION="1cdccc4d006cc26abc6312edbeae58f3081200d4" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 24 Feb 2022 07:16:13 PM CET" VOLUMIO_VERSION="3.233" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="88d67d58bfcedcd908dd7b955a1fa5bd"