-- Logs begin at Sat 2024-09-28 12:10:54 CST, end at Fri 2025-02-21 23:29:37 CST. -- Feb 21 23:28:13 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:13 volumio volumio[14744]: info: TuneIn handleBrowseUri: tunein/local Feb 21 23:28:15 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:15 volumio volumio[14744]: info: TuneIn handleBrowseUri: tunein/local Feb 21 23:28:15 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:15 volumio volumio[14744]: info: TuneIn handleBrowseUri: tunein/local Feb 21 23:28:24 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:24 volumio volumio[14744]: info: TuneIn handleBrowseUri: tunein/best Feb 21 23:28:27 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:27 volumio volumio[14744]: info: TuneIn handleBrowseUri: tunein/best Feb 21 23:28:27 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:27 volumio volumio[14744]: info: TuneIn handleBrowseUri: tunein/best Feb 21 23:28:37 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:37 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:28:40 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 23:28:40 volumio volumio[14744]: info: Getting webradio selection Feb 21 23:28:41 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:28:42 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:42 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:42 volumio volumio[14744]: info: Prefetching next song Feb 21 23:28:42 volumio volumio[14744]: info: DOING PREFETCH IN MPD Feb 21 23:28:42 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "USB/7254-4C56/010.相识廿载 演唱会87 - 做人要识Do (Live).wav" Feb 21 23:28:42 volumio volumio[14744]: info: Feb 21 23:28:42 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:42 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:42 volumio volumio[14744]: info: sendMpdCommand add "USB/7254-4C56/010.相识廿载 演唱会87 - 做人要识Do (Live).wav" took 2 milliseconds Feb 21 23:28:42 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand consume 1 Feb 21 23:28:42 volumio volumio[14744]: info: Feb 21 23:28:42 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:42 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:42 volumio volumio[14744]: info: Feb 21 23:28:42 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:42 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:42 volumio volumio[14744]: info: Feb 21 23:28:42 volumio volumio[14744]: ---------------------------- MPD announces state update: options Feb 21 23:28:42 volumio volumio[14744]: info: ------------------------------ 7ms Feb 21 23:28:42 volumio volumio[14744]: info: sendMpdCommand consume 1 took 6 milliseconds Feb 21 23:28:42 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:42 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:42 volumio volumio[14744]: info: ------------------------------ 6ms Feb 21 23:28:42 volumio volumio[14744]: info: ------------------------------ 6ms Feb 21 23:28:43 volumio volumio[14744]: info: Feb 21 23:28:43 volumio volumio[14744]: ---------------------------- MPD announces state update: options Feb 21 23:28:43 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:43 volumio volumio[14744]: info: Feb 21 23:28:43 volumio volumio[14744]: ---------------------------- MPD announces state update: options Feb 21 23:28:43 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:43 volumio volumio[14744]: info: sendMpdCommand status took 10 milliseconds Feb 21 23:28:43 volumio volumio[14744]: info: sendMpdCommand status took 4 milliseconds Feb 21 23:28:43 volumio volumio[14744]: info: sendMpdCommand status took 2 milliseconds Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:28:43 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 21 23:28:43 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 21 23:28:43 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:28:43 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:28:43 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364978,"duration":370,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"008.相识廿载 演唱会87 - Medley：咪当我老衬+佛跳墙+钱会继续嚟.wav","artist":null,"album":null,"uri":"USB/7254-4C56/008.相识廿载 演唱会87 - Medley：咪当我老衬+佛跳墙+钱会继续嚟.wav","trackType":"wav"} Feb 21 23:28:43 volumio volumio[14744]: verbose: CURRENT POSITION 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::syncState stateService play Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus play Feb 21 23:28:43 volumio volumio[14744]: info: Received an update from plugin. extracting info from payload Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:43 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364978,"duration":370,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"008.相识廿载 演唱会87 - Medley：咪当我老衬+佛跳墙+钱会继续嚟.wav","artist":null,"album":null,"uri":"USB/7254-4C56/008.相识廿载 演唱会87 - Medley：咪当我老衬+佛跳墙+钱会继续嚟.wav","trackType":"wav"} Feb 21 23:28:43 volumio volumio[14744]: verbose: CURRENT POSITION 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::syncState stateService play Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus play Feb 21 23:28:43 volumio volumio[14744]: info: Received an update from plugin. extracting info from payload Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:43 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: verbose: STATE SERVICE {"status":"play","position":0,"seek":364978,"duration":370,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"008.相识廿载 演唱会87 - Medley：咪当我老衬+佛跳墙+钱会继续嚟.wav","artist":null,"album":null,"uri":"USB/7254-4C56/008.相识廿载 演唱会87 - Medley：咪当我老衬+佛跳墙+钱会继续嚟.wav","trackType":"wav"} Feb 21 23:28:43 volumio volumio[14744]: verbose: CURRENT POSITION 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::syncState stateService play Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus play Feb 21 23:28:43 volumio volumio[14744]: info: Received an update from plugin. extracting info from payload Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:43 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:43 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:43 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:43 volumio volumio[14744]: info: ------------------------------ 95ms Feb 21 23:28:43 volumio volumio[14744]: info: ------------------------------ 87ms Feb 21 23:28:43 volumio volumio[14744]: info: ------------------------------ 86ms Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: info: Feb 21 23:28:47 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:47 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:47 volumio volumio[14744]: info: Feb 21 23:28:47 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:28:47 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:47 volumio volumio[14744]: info: Feb 21 23:28:47 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:47 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:47 volumio volumio[14744]: info: Feb 21 23:28:47 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:28:47 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:47 volumio volumio[14744]: info: ------------------------------ 5ms Feb 21 23:28:47 volumio volumio[14744]: info: sendMpdCommand status took 4 milliseconds Feb 21 23:28:47 volumio volumio[14744]: info: ------------------------------ 5ms Feb 21 23:28:47 volumio volumio[14744]: info: sendMpdCommand status took 3 milliseconds Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:28:47 volumio volumio[14744]: info: Feb 21 23:28:47 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:47 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:47 volumio volumio[14744]: info: Feb 21 23:28:47 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:28:47 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:47 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 21 23:28:47 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 21 23:28:47 volumio volumio[14744]: info: ------------------------------ 4ms Feb 21 23:28:47 volumio volumio[14744]: info: sendMpdCommand status took 2 milliseconds Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:28:47 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"010.相识廿载 演唱会87 - 做人要识Do (Live).wav","artist":null,"album":null,"uri":"USB/7254-4C56/010.相识廿载 演唱会87 - 做人要识Do (Live).wav","trackType":"wav"} Feb 21 23:28:47 volumio volumio[14744]: verbose: CURRENT POSITION 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::syncState stateService play Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus play Feb 21 23:28:47 volumio volumio[14744]: info: Received an update from plugin. extracting info from payload Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:47 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"010.相识廿载 演唱会87 - 做人要识Do (Live).wav","artist":null,"album":null,"uri":"USB/7254-4C56/010.相识廿载 演唱会87 - 做人要识Do (Live).wav","trackType":"wav"} Feb 21 23:28:47 volumio volumio[14744]: verbose: CURRENT POSITION 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::syncState stateService play Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus play Feb 21 23:28:47 volumio volumio[14744]: info: Received an update from plugin. extracting info from payload Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:47 volumio volumio[14744]: info: ------------------------------ 71ms Feb 21 23:28:47 volumio volumio[14744]: info: ------------------------------ 71ms Feb 21 23:28:47 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 61 milliseconds Feb 21 23:28:47 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:28:47 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":292,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"010.相识廿载 演唱会87 - 做人要识Do (Live).wav","artist":null,"album":null,"uri":"USB/7254-4C56/010.相识廿载 演唱会87 - 做人要识Do (Live).wav","trackType":"wav"} Feb 21 23:28:47 volumio volumio[14744]: verbose: CURRENT POSITION 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::syncState stateService play Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus play Feb 21 23:28:47 volumio volumio[14744]: info: Received an update from plugin. extracting info from payload Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:47 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:47 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:47 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:47 volumio volumio[14744]: info: ------------------------------ 108ms Feb 21 23:28:48 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:48 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:48 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:50 volumio volumio[14744]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioGetState Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:50 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::ClearQueue Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::stPlaybackTimer Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::serviceStop Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 1 Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::serviceStop Feb 21 23:28:50 volumio volumio[14744]: info: ControllerMpd::stop Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::clearPlayQueue Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::addQueueItems Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::addQueueItems Feb 21 23:28:50 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:28:50 volumio volumio[14744]: info: Adding Item to queue: http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3 Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::play index 0 Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:50 volumio volumio[14744]: info: [1740151730747] ControllerWebradio::clearAddPlayTrack Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:28:50 volumio volumio[14744]: info: Feb 21 23:28:50 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:28:50 volumio volumio[14744]: info: sendMpdCommand stop took 45 milliseconds Feb 21 23:28:50 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:50 volumio volumio[14744]: info: sendMpdCommand stop took 14 milliseconds Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:28:50 volumio volumio[14744]: info: Feb 21 23:28:50 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:28:50 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:50 volumio volumio[14744]: info: Feb 21 23:28:50 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:28:50 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:28:50 volumio volumio[14744]: info: Feb 21 23:28:50 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:50 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:50 volumio volumio[14744]: info: sendMpdCommand status took 9 milliseconds Feb 21 23:28:50 volumio volumio[14744]: info: sendMpdCommand clear took 7 milliseconds Feb 21 23:28:50 volumio volumio[14744]: info: sendMpdCommand status took 8 milliseconds Feb 21 23:28:50 volumio volumio[14744]: info: sendMpdCommand status took 7 milliseconds Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3" Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:28:50 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:50 volumio volumio[14744]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 23:28:50 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:28:50 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:50 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:28:50 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:50 volumio volumio[14744]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 23:28:50 volumio volumio[14744]: info: ------------------------------ 37ms Feb 21 23:28:50 volumio volumio[14744]: info: ------------------------------ 36ms Feb 21 23:28:50 volumio volumio[14744]: info: Feb 21 23:28:50 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:50 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:50 volumio volumio[14744]: info: Feb 21 23:28:50 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:28:50 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:28:50 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:28:50 volumio volumio[14744]: info: ------------------------------ 67ms Feb 21 23:28:50 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 62 milliseconds Feb 21 23:28:50 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:28:50 volumio volumio[14744]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 21 23:28:50 volumio volumio[14744]: info: ------------------------------ 81ms Feb 21 23:28:50 volumio volumio[14744]: info: touch_display: Setting screensaver timeout to 120 seconds. Feb 21 23:28:52 volumio volumio[14744]: info: peppy_screensaver: Start PeppyMeter Feb 21 23:28:59 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:28:59 volumio volumio[14744]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::ClearQueue Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:59 volumio volumio[14744]: info: CorePlayQueue::clearPlayQueue Feb 21 23:28:59 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:28:59 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::addQueueItems Feb 21 23:28:59 volumio volumio[14744]: info: CorePlayQueue::addQueueItems Feb 21 23:28:59 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:28:59 volumio volumio[14744]: info: Adding Item to queue: https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3 Feb 21 23:28:59 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 23:28:59 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:28:59 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:28:59 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:28:59 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::play index 0 Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:28:59 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:59 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:28:59 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:28:59 volumio volumio[14744]: info: [1740151739972] ControllerWebradio::clearAddPlayTrack Feb 21 23:28:59 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:01 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:01 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:01 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3" Feb 21 23:29:01 volumio volumio[14744]: info: ------------------------------ 10734ms Feb 21 23:29:01 volumio volumio[14744]: info: ------------------------------ 10733ms Feb 21 23:29:01 volumio volumio[14744]: info: sendMpdCommand stop took 1566 milliseconds Feb 21 23:29:01 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:01 volumio volumio[14744]: info: Feb 21 23:29:01 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:01 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:01 volumio volumio[14744]: info: Feb 21 23:29:01 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:01 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:01 volumio volumio[14744]: info: sendMpdCommand add "http://icecast.radiofrance.fr/francemusiqueclassiqueplus-midfi.mp3" took 2 milliseconds Feb 21 23:29:01 volumio volumio[14744]: info: sendMpdCommand clear took 1 milliseconds Feb 21 23:29:01 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:01 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:01 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Feb 21 23:29:01 volumio volumio[14744]: info: Feb 21 23:29:01 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:01 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:01 volumio volumio[14744]: info: Feb 21 23:29:01 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:01 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:01 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:01 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:01 volumio volumio[14744]: info: ------------------------------ 5ms Feb 21 23:29:01 volumio volumio[14744]: info: ------------------------------ 5ms Feb 21 23:29:01 volumio volumio[14744]: info: sendMpdCommand play took 4 milliseconds Feb 21 23:29:02 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:02 volumio volumio[14744]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::ClearQueue Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:02 volumio volumio[14744]: info: CorePlayQueue::clearPlayQueue Feb 21 23:29:02 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:02 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::addQueueItems Feb 21 23:29:02 volumio volumio[14744]: info: CorePlayQueue::addQueueItems Feb 21 23:29:02 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:02 volumio volumio[14744]: info: Adding Item to queue: http://media-ice.musicradio.com/ClassicFMMP3 Feb 21 23:29:02 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 23:29:02 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:02 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:29:02 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:29:02 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::play index 0 Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:02 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:02 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:02 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:02 volumio volumio[14744]: info: [1740151742530] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:02 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:05 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:05 volumio volumio[14744]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::ClearQueue Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:05 volumio volumio[14744]: info: CorePlayQueue::clearPlayQueue Feb 21 23:29:05 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:05 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::addQueueItems Feb 21 23:29:05 volumio volumio[14744]: info: CorePlayQueue::addQueueItems Feb 21 23:29:05 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:05 volumio volumio[14744]: info: Adding Item to queue: http://kdhx-ice.streamguys1.com:80/live Feb 21 23:29:05 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 23:29:05 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:05 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:29:05 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:29:05 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::play index 0 Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:05 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:05 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:05 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:05 volumio volumio[14744]: info: [1740151745910] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:05 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:09 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:09 volumio volumio[14744]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::ClearQueue Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:09 volumio volumio[14744]: info: CorePlayQueue::clearPlayQueue Feb 21 23:29:09 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:09 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::addQueueItems Feb 21 23:29:09 volumio volumio[14744]: info: CorePlayQueue::addQueueItems Feb 21 23:29:09 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:09 volumio volumio[14744]: info: Adding Item to queue: http://kdhx-ice.streamguys1.com:80/live Feb 21 23:29:09 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 23:29:09 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:09 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:29:09 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:29:09 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::play index 0 Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:09 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:09 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:09 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:09 volumio volumio[14744]: info: [1740151749319] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:09 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:11 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:11 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:11 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:11 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:11 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:11 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:11 volumio volumio[14744]: info: [1740151751886] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:11 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:15 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:15 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:15 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:15 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:15 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:15 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:15 volumio volumio[14744]: info: [1740151755710] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:15 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:16 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:16 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:16 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:16 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:16 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:16 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:16 volumio volumio[14744]: info: [1740151756902] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:16 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 15813ms Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 15812ms Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand stop took 14825 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand stop took 11445 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand stop took 8035 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand stop took 5468 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand stop took 1646 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand stop took 454 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand add "https://edge56.live-sm.absolutradio.de/absolut-relax/stream/mp3" took 3 milliseconds Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:17 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 8ms Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand clear took 7 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand clear took 7 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand clear took 6 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand clear took 6 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand clear took 6 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand clear took 7 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: sendMpdCommand play took 7 milliseconds Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 6ms Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 5ms Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://media-ice.musicradio.com/ClassicFMMP3" Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:17 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: info: Feb 21 23:29:17 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:17 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 9ms Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 10ms Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 9ms Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 9ms Feb 21 23:29:17 volumio volumio[14744]: info: ------------------------------ 9ms Feb 21 23:29:18 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://media-ice.musicradio.com/ClassicFMMP3" Feb 21 23:29:20 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:20 volumio volumio[14744]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::ClearQueue Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:20 volumio volumio[14744]: info: CorePlayQueue::clearPlayQueue Feb 21 23:29:20 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:20 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::addQueueItems Feb 21 23:29:20 volumio volumio[14744]: info: CorePlayQueue::addQueueItems Feb 21 23:29:20 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:20 volumio volumio[14744]: info: Adding Item to queue: http://stream.radioparadise.com/mellow-flacm Feb 21 23:29:20 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 23:29:20 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:20 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:29:20 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:29:20 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::play index 0 Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:20 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:20 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:20 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:20 volumio volumio[14744]: info: [1740151760270] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:20 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:23 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:23 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 5888ms Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 5888ms Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand add "http://media-ice.musicradio.com/ClassicFMMP3" took 4726 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand stop took 2992 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" took 8 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" took 8 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" took 9 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" took 8 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand add "http://kdhx-ice.streamguys1.com:80/live" took 8 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:23 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:23 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:23 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:23 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:23 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 16ms Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 16ms Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 16ms Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 15ms Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 14ms Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 14ms Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand play took 12 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand clear took 242 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand play took 243 milliseconds Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "http://stream.radioparadise.com/mellow-flacm" Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:29:23 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:23 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:23 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand play took 246 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand play took 246 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand play took 246 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: sendMpdCommand play took 245 milliseconds Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 244ms Feb 21 23:29:23 volumio volumio[14744]: info: ------------------------------ 243ms Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:29:23 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:23 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:23 volumio volumio[14744]: info: Feb 21 23:29:23 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:29:23 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:29:23 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand add "http://stream.radioparadise.com/mellow-flacm" Feb 21 23:29:26 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:26 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:26 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:26 volumio volumio[14744]: info: Feb 21 23:29:26 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:26 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 2848ms Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand status took 2846 milliseconds Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 2844ms Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand status took 2843 milliseconds Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 2842ms Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand status took 2840 milliseconds Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand add "http://stream.radioparadise.com/mellow-flacm" took 4 milliseconds Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand play Feb 21 23:29:26 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:26 volumio volumio[14744]: 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 21 23:29:26 volumio volumio[14744]: verbose: CURRENT POSITION 0 Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::syncState stateService stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: No code Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:26 volumio volumio[14744]: 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 21 23:29:26 volumio volumio[14744]: verbose: CURRENT POSITION 0 Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::syncState stateService stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: No code Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: ControllerMpd::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::servicePushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:26 volumio volumio[14744]: 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 21 23:29:26 volumio volumio[14744]: verbose: CURRENT POSITION 0 Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::syncState stateService stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::syncState currentStatus stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: No code Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::pushState Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushState Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 2954ms Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 2951ms Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 2951ms Feb 21 23:29:26 volumio volumio[14744]: info: Feb 21 23:29:26 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:26 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:26 volumio volumio[14744]: info: Feb 21 23:29:26 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:26 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 125ms Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand play took 122 milliseconds Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 13ms Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 6ms Feb 21 23:29:26 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::ClearQueue Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::clearPlayQueue Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::addQueueItems Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::addQueueItems Feb 21 23:29:26 volumio volumio[14744]: info: Preload queue cleared Feb 21 23:29:26 volumio volumio[14744]: info: Adding Item to queue: https://listen-msmn.sharp-stream.com/nme2.mp3 Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPushQueue Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::saveQueue Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::updateTrackBlock Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::getTrackBlock Feb 21 23:29:26 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::play index 0 Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::stop Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:26 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:26 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:26 volumio volumio[14744]: info: [1740151766729] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:26 volumio volumio[14744]: info: Feb 21 23:29:26 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand stop took 3 milliseconds Feb 21 23:29:26 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 23:29:26 volumio volumio[14744]: info: Feb 21 23:29:26 volumio volumio[14744]: ---------------------------- MPD announces system playlist update Feb 21 23:29:26 volumio volumio[14744]: info: Ignoring MPD Status Update Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand status took 2 milliseconds Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand clear took 2 milliseconds Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::parseState Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand load "https://listen-msmn.sharp-stream.com/nme2.mp3" Feb 21 23:29:26 volumio volumio[14744]: info: Feb 21 23:29:26 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:29:26 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:29:26 volumio volumio[14744]: info: Feb 21 23:29:26 volumio volumio[14744]: ---------------------------- MPD announces state update: player Feb 21 23:29:26 volumio volumio[14744]: info: ControllerMpd::getState Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand status Feb 21 23:29:26 volumio volumio[14744]: error: updateQueue error: null Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 12ms Feb 21 23:29:26 volumio volumio[14744]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 21 23:29:26 volumio volumio[14744]: verbose: ControllerMpd::parseTrackInfo Feb 21 23:29:26 volumio volumio[14744]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 21 23:29:26 volumio volumio[14744]: info: ------------------------------ 18ms Feb 21 23:29:31 volumio volumio[14744]: info: CoreCommandRouter::volumioPlay Feb 21 23:29:31 volumio volumio[14744]: info: CoreStateMachine::play index undefined Feb 21 23:29:31 volumio volumio[14744]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 23:29:31 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:31 volumio volumio[14744]: info: CoreStateMachine::startPlaybackTimer Feb 21 23:29:31 volumio volumio[14744]: info: CorePlayQueue::getTrack 0 Feb 21 23:29:31 volumio volumio[14744]: info: [1740151771904] ControllerWebradio::clearAddPlayTrack Feb 21 23:29:31 volumio volumio[14744]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 23:29:37 volumio volumio[14744]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 23:29:37 volumio volumio[14744]: Error: connect ETIMEDOUT 199.16.156.38:443 Feb 21 23:29:37 volumio volumio[14744]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Feb 21 23:29:37 volumio volumio[14744]: errno: -110, Feb 21 23:29:37 volumio volumio[14744]: code: 'ETIMEDOUT', Feb 21 23:29:37 volumio volumio[14744]: syscall: 'connect', Feb 21 23:29:37 volumio volumio[14744]: address: '199.16.156.38', Feb 21 23:29:37 volumio volumio[14744]: port: 443 Feb 21 23:29:37 volumio volumio[14744]: } Feb 21 23:29:37 volumio volumio[14744]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 23:29:37 volumio sudo[15608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-21 23:28 Feb 21 23:29:37 volumio sudo[15608]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"