-- Logs begin at Thu 2019-02-14 15:11:59 +05, end at Tue 2026-02-17 09:08:30 +05. -- Feb 17 09:07:10 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 17 09:07:12 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:07:22 volumio volumio[1022]: info: CoreCommandRouter::volumioGetState Feb 17 09:07:22 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:32 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 17 09:07:32 volumio volumio[1022]: info: TuneIn handleBrowseUri: tunein/popular Feb 17 09:07:32 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:07:39 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 17 09:07:39 volumio volumio[1022]: info: Getting webradio selection Feb 17 09:07:39 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:07:45 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:07:45 volumio volumio[1022]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::ClearQueue Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::stop Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:45 volumio volumio[1022]: info: CorePlayQueue::clearPlayQueue Feb 17 09:07:45 volumio volumio[1022]: info: CorePlayQueue::saveQueue Feb 17 09:07:45 volumio volumio[1022]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::addQueueItems Feb 17 09:07:45 volumio volumio[1022]: info: CorePlayQueue::addQueueItems Feb 17 09:07:45 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:07:45 volumio volumio[1022]: info: Adding Item to queue: https://ibizasonica.streaming-pro.com:8011/sonicaclub Feb 17 09:07:45 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 17 09:07:45 volumio volumio[1022]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:07:45 volumio volumio[1022]: info: CorePlayQueue::saveQueue Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::updateTrackBlock Feb 17 09:07:45 volumio volumio[1022]: info: CorePlayQueue::getTrackBlock Feb 17 09:07:45 volumio volumio[1022]: info: CoreCommandRouter::volumioPlay Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::play index 0 Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::stop Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::play index undefined Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:45 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:45 volumio volumio[1022]: info: CoreStateMachine::startPlaybackTimer Feb 17 09:07:45 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:45 volumio volumio[1022]: info: [1771301265971] ControllerWebradio::clearAddPlayTrack Feb 17 09:07:45 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 09:07:45 volumio volumio[1022]: info: sendMpdCommand stop took 14 milliseconds Feb 17 09:07:45 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 09:07:45 volumio volumio[1022]: info: sendMpdCommand clear took 2 milliseconds Feb 17 09:07:45 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand load "https://ibizasonica.streaming-pro.com:8011/sonicaclub" Feb 17 09:07:45 volumio volumio[1022]: info: Feb 17 09:07:45 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:46 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:46 volumio volumio[1022]: info: Feb 17 09:07:46 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:46 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:46 volumio volumio[1022]: info: Feb 17 09:07:46 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:46 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:46 volumio volumio[1022]: error: Upnp client error: Error: This socket has been ended by the other party Feb 17 09:07:48 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand add "https://ibizasonica.streaming-pro.com:8011/sonicaclub" Feb 17 09:07:48 volumio volumio[1022]: error: updateQueue error: null Feb 17 09:07:48 volumio volumio[1022]: error: updateQueue error: null Feb 17 09:07:48 volumio volumio[1022]: error: updateQueue error: null Feb 17 09:07:48 volumio volumio[1022]: info: Feb 17 09:07:48 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:48 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:48 volumio volumio[1022]: info: ------------------------------ 2419ms Feb 17 09:07:48 volumio volumio[1022]: info: ------------------------------ 2413ms Feb 17 09:07:48 volumio volumio[1022]: info: ------------------------------ 2407ms Feb 17 09:07:48 volumio volumio[1022]: info: sendMpdCommand add "https://ibizasonica.streaming-pro.com:8011/sonicaclub" took 12 milliseconds Feb 17 09:07:48 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 09:07:48 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand play Feb 17 09:07:48 volumio volumio[1022]: info: Feb 17 09:07:48 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:48 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:48 volumio volumio[1022]: info: Feb 17 09:07:48 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:48 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:48 volumio volumio[1022]: info: ------------------------------ 22ms Feb 17 09:07:48 volumio volumio[1022]: info: sendMpdCommand play took 16 milliseconds Feb 17 09:07:48 volumio volumio[1022]: info: ------------------------------ 13ms Feb 17 09:07:48 volumio volumio[1022]: info: ------------------------------ 10ms Feb 17 09:07:49 volumio volumio[1022]: info: Feb 17 09:07:49 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:49 volumio volumio[1022]: info: Feb 17 09:07:49 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:49 volumio volumio[1022]: info: Feb 17 09:07:49 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand status took 9 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand status took 7 milliseconds Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:49 volumio volumio[1022]: info: Feb 17 09:07:49 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:49 volumio volumio[1022]: info: Feb 17 09:07:49 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand status took 20 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 14 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand status took 9 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand status took 6 milliseconds Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:49 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:49 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:49 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: ------------------------------ 97ms Feb 17 09:07:49 volumio volumio[1022]: info: ------------------------------ 112ms Feb 17 09:07:49 volumio volumio[1022]: info: Feb 17 09:07:49 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 79 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 73 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 72 milliseconds Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand status took 5 milliseconds Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:49 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:49 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:49 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:49 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:49 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:49 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: ------------------------------ 241ms Feb 17 09:07:49 volumio volumio[1022]: info: ------------------------------ 227ms Feb 17 09:07:49 volumio volumio[1022]: info: ------------------------------ 225ms Feb 17 09:07:49 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 149 milliseconds Feb 17 09:07:49 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:49 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:49 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:49 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:49 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:49 volumio volumio[1022]: info: ------------------------------ 204ms Feb 17 09:07:50 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::ClearQueue Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::stop Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::stPlaybackTimer Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::updateTrackBlock Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrackBlock Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::serviceStop Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::serviceStop Feb 17 09:07:50 volumio volumio[1022]: info: [1771301270290] ControllerWebradio::stop Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::clearPlayQueue Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::saveQueue Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::addQueueItems Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::addQueueItems Feb 17 09:07:50 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:07:50 volumio volumio[1022]: info: Adding Item to queue: https://ibizasonica.streaming-pro.com:8011/sonicaclub Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::saveQueue Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::updateTrackBlock Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrackBlock Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::volumioPlay Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::play index 0 Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::stop Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::play index undefined Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::startPlaybackTimer Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: [1771301270337] ControllerWebradio::clearAddPlayTrack Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 09:07:50 volumio volumio[1022]: info: Feb 17 09:07:50 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:50 volumio volumio[1022]: info: sendMpdCommand stop took 55 milliseconds Feb 17 09:07:50 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:50 volumio volumio[1022]: info: sendMpdCommand stop took 10 milliseconds Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 09:07:50 volumio volumio[1022]: info: Feb 17 09:07:50 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:50 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:50 volumio volumio[1022]: info: Feb 17 09:07:50 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:50 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:50 volumio volumio[1022]: info: Feb 17 09:07:50 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:50 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:50 volumio volumio[1022]: info: sendMpdCommand status took 14 milliseconds Feb 17 09:07:50 volumio volumio[1022]: info: sendMpdCommand clear took 13 milliseconds Feb 17 09:07:50 volumio volumio[1022]: info: sendMpdCommand status took 10 milliseconds Feb 17 09:07:50 volumio volumio[1022]: info: sendMpdCommand status took 8 milliseconds Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand load "https://ibizasonica.streaming-pro.com:8011/sonicaclub" Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:50 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 09:07:50 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:50 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:50 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:50 volumio volumio[1022]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 09:07:50 volumio volumio[1022]: info: ------------------------------ 68ms Feb 17 09:07:50 volumio volumio[1022]: info: ------------------------------ 66ms Feb 17 09:07:50 volumio volumio[1022]: info: Feb 17 09:07:50 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:50 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:50 volumio volumio[1022]: info: Feb 17 09:07:50 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:50 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:50 volumio volumio[1022]: error: updateQueue error: null Feb 17 09:07:50 volumio volumio[1022]: info: ------------------------------ 71ms Feb 17 09:07:50 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 66 milliseconds Feb 17 09:07:50 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:50 volumio volumio[1022]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 17 09:07:50 volumio volumio[1022]: info: ------------------------------ 91ms Feb 17 09:07:51 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand add "https://ibizasonica.streaming-pro.com:8011/sonicaclub" Feb 17 09:07:51 volumio volumio[1022]: error: updateQueue error: null Feb 17 09:07:51 volumio volumio[1022]: error: updateQueue error: null Feb 17 09:07:51 volumio volumio[1022]: info: Feb 17 09:07:51 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:51 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:51 volumio volumio[1022]: info: ------------------------------ 884ms Feb 17 09:07:51 volumio volumio[1022]: info: ------------------------------ 882ms Feb 17 09:07:51 volumio volumio[1022]: info: sendMpdCommand add "https://ibizasonica.streaming-pro.com:8011/sonicaclub" took 6 milliseconds Feb 17 09:07:51 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 09:07:51 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand play Feb 17 09:07:51 volumio volumio[1022]: info: Feb 17 09:07:51 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:51 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:51 volumio volumio[1022]: info: Feb 17 09:07:51 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:07:51 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:07:51 volumio volumio[1022]: info: ------------------------------ 17ms Feb 17 09:07:51 volumio volumio[1022]: info: sendMpdCommand play took 14 milliseconds Feb 17 09:07:51 volumio volumio[1022]: info: ------------------------------ 12ms Feb 17 09:07:51 volumio volumio[1022]: info: ------------------------------ 9ms Feb 17 09:07:52 volumio volumio[1022]: info: Feb 17 09:07:52 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:52 volumio volumio[1022]: info: Feb 17 09:07:52 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:52 volumio volumio[1022]: info: Feb 17 09:07:52 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:52 volumio volumio[1022]: info: Feb 17 09:07:52 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand status took 12 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand status took 9 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand status took 6 milliseconds Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:52 volumio volumio[1022]: info: Feb 17 09:07:52 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:52 volumio volumio[1022]: info: Feb 17 09:07:52 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand status took 17 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 13 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand status took 9 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand status took 6 milliseconds Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:52 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:52 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:52 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:52 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:52 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: ------------------------------ 87ms Feb 17 09:07:52 volumio volumio[1022]: info: ------------------------------ 125ms Feb 17 09:07:52 volumio volumio[1022]: info: ------------------------------ 123ms Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 104 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 102 milliseconds Feb 17 09:07:52 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 102 milliseconds Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:52 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:52 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:52 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:52 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:52 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: 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":"sonicaclub","artist":null,"album":null,"uri":"https://ibizasonica.streaming-pro.com:8011/sonicaclub","trackType":""} Feb 17 09:07:52 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:07:52 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:07:52 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:07:52 volumio volumio[1022]: info: ------------------------------ 248ms Feb 17 09:07:52 volumio volumio[1022]: info: ------------------------------ 239ms Feb 17 09:07:52 volumio volumio[1022]: info: ------------------------------ 237ms Feb 17 09:08:10 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 17 09:08:10 volumio volumio[1022]: info: TuneIn handleBrowseUri: tunein/local Feb 17 09:08:10 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:08:14 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 17 09:08:14 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:08:22 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:08:22 volumio volumio[1022]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::ClearQueue Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::stop Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::stPlaybackTimer Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::updateTrackBlock Feb 17 09:08:22 volumio volumio[1022]: info: CorePlayQueue::getTrackBlock Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:22 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:22 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:08:22 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::serviceStop Feb 17 09:08:22 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:22 volumio volumio[1022]: info: CoreCommandRouter::serviceStop Feb 17 09:08:22 volumio volumio[1022]: info: [1771301302970] ControllerWebradio::stop Feb 17 09:08:22 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 09:08:22 volumio volumio[1022]: info: CorePlayQueue::clearPlayQueue Feb 17 09:08:22 volumio volumio[1022]: info: CorePlayQueue::saveQueue Feb 17 09:08:22 volumio volumio[1022]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:08:22 volumio volumio[1022]: info: CoreStateMachine::addQueueItems Feb 17 09:08:22 volumio volumio[1022]: info: CorePlayQueue::addQueueItems Feb 17 09:08:22 volumio volumio[1022]: info: Preload queue cleared Feb 17 09:08:22 volumio volumio[1022]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Feb 17 09:08:22 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 17 09:08:23 volumio volumio[1022]: info: CoreCommandRouter::volumioPushQueue Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::saveQueue Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::updateTrackBlock Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::getTrackBlock Feb 17 09:08:23 volumio volumio[1022]: info: CoreCommandRouter::volumioPlay Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::play index 0 Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::stop Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::play index undefined Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::startPlaybackTimer Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:23 volumio volumio[1022]: info: [1771301303024] ControllerWebradio::clearAddPlayTrack Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand stop Feb 17 09:08:23 volumio volumio[1022]: info: Feb 17 09:08:23 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:23 volumio volumio[1022]: info: sendMpdCommand stop took 62 milliseconds Feb 17 09:08:23 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:23 volumio volumio[1022]: info: sendMpdCommand stop took 11 milliseconds Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand clear Feb 17 09:08:23 volumio volumio[1022]: info: Feb 17 09:08:23 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:23 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:23 volumio volumio[1022]: info: Feb 17 09:08:23 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:23 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:23 volumio volumio[1022]: info: Feb 17 09:08:23 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:23 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:23 volumio volumio[1022]: info: sendMpdCommand status took 13 milliseconds Feb 17 09:08:23 volumio volumio[1022]: info: sendMpdCommand clear took 12 milliseconds Feb 17 09:08:23 volumio volumio[1022]: info: sendMpdCommand status took 10 milliseconds Feb 17 09:08:23 volumio volumio[1022]: info: sendMpdCommand status took 7 milliseconds Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:23 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:23 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:23 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:08:23 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:23 volumio volumio[1022]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 09:08:23 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:23 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:23 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:23 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:23 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:23 volumio volumio[1022]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 17 09:08:23 volumio volumio[1022]: info: ------------------------------ 68ms Feb 17 09:08:23 volumio volumio[1022]: info: ------------------------------ 66ms Feb 17 09:08:23 volumio volumio[1022]: info: Feb 17 09:08:23 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:23 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:23 volumio volumio[1022]: info: Feb 17 09:08:23 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:23 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:23 volumio volumio[1022]: error: updateQueue error: null Feb 17 09:08:23 volumio volumio[1022]: info: ------------------------------ 72ms Feb 17 09:08:23 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 67 milliseconds Feb 17 09:08:23 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:23 volumio volumio[1022]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 17 09:08:23 volumio volumio[1022]: info: ------------------------------ 90ms Feb 17 09:08:24 volumio volumio[1022]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 1350 milliseconds Feb 17 09:08:24 volumio volumio[1022]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 17 09:08:24 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand play Feb 17 09:08:24 volumio volumio[1022]: info: Feb 17 09:08:24 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:24 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:24 volumio volumio[1022]: info: ------------------------------ 1301ms Feb 17 09:08:24 volumio volumio[1022]: info: ------------------------------ 1299ms Feb 17 09:08:24 volumio volumio[1022]: info: sendMpdCommand play took 6 milliseconds Feb 17 09:08:24 volumio volumio[1022]: info: Feb 17 09:08:24 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:24 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:24 volumio volumio[1022]: info: Feb 17 09:08:24 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:24 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:24 volumio volumio[1022]: info: ------------------------------ 16ms Feb 17 09:08:24 volumio volumio[1022]: info: ------------------------------ 10ms Feb 17 09:08:24 volumio volumio[1022]: info: ------------------------------ 6ms Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 16 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 12 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 8 milliseconds Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:26 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:26 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 26 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 24 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 22 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 23 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 18 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 20 milliseconds Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: 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":"dance.mp3","artist":"(#1 - 5976/32000) Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus stop Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: 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":"dance.mp3","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: 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":"dance.mp3","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 114ms Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 164ms Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 161ms Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:26 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:26 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 146ms Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 138 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 145ms Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 138 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 130 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 126 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 124 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 20ms Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 17 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 16ms Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 13 milliseconds Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: 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":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: verbose: STATE SERVICE {"status":"play","position":0,"seek":560,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1154,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 316ms Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 304ms Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 301ms Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces system playlist update Feb 17 09:08:26 volumio volumio[1022]: info: Ignoring MPD Status Update Feb 17 09:08:26 volumio volumio[1022]: info: Feb 17 09:08:26 volumio volumio[1022]: ---------------------------- MPD announces state update: player Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::getState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand status Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 167 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 167 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 164 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 163 milliseconds Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 34ms Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand status took 32 milliseconds Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseState Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1154,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1154,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1154,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1154,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 507ms Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 507ms Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 380ms Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 377ms Feb 17 09:08:26 volumio volumio[1022]: info: sendMpdCommand playlistinfo took 193 milliseconds Feb 17 09:08:26 volumio volumio[1022]: verbose: ControllerMpd::parseTrackInfo Feb 17 09:08:26 volumio volumio[1022]: info: ControllerMpd::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::servicePushState Feb 17 09:08:26 volumio volumio[1022]: info: CorePlayQueue::getTrack 0 Feb 17 09:08:26 volumio volumio[1022]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1314,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"All about Dance from 2000 till today!","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 17 09:08:26 volumio volumio[1022]: verbose: CURRENT POSITION 0 Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState stateService play Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::syncState currentStatus play Feb 17 09:08:26 volumio volumio[1022]: info: Received an update from plugin. extracting info from payload Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreStateMachine::pushState Feb 17 09:08:26 volumio volumio[1022]: info: CoreCommandRouter::volumioPushState Feb 17 09:08:26 volumio volumio[1022]: info: ------------------------------ 278ms Feb 17 09:08:29 volumio volumio[1022]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 09:08:29 volumio volumio[1022]: TypeError: Cannot read property 'slice' of null Feb 17 09:08:29 volumio volumio[1022]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 17 09:08:29 volumio volumio[1022]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 17 09:08:29 volumio volumio[1022]: at Object.onceWrapper (events.js:520:26) Feb 17 09:08:29 volumio volumio[1022]: at ClientRequest.emit (events.js:400:28) Feb 17 09:08:29 volumio volumio[1022]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:647:27) Feb 17 09:08:29 volumio volumio[1022]: at HTTPParser.parserOnHeadersComplete (_http_common.js:127:17) Feb 17 09:08:29 volumio volumio[1022]: at TLSSocket.socketOnData (_http_client.js:515:22) Feb 17 09:08:29 volumio volumio[1022]: at TLSSocket.emit (events.js:400:28) Feb 17 09:08:29 volumio volumio[1022]: at addChunk (internal/streams/readable.js:293:12) Feb 17 09:08:29 volumio volumio[1022]: at readableAddChunk (internal/streams/readable.js:267:9) Feb 17 09:08:29 volumio volumio[1022]: at TLSSocket.Readable.push (internal/streams/readable.js:206:10) Feb 17 09:08:29 volumio volumio[1022]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Feb 17 09:08:29 volumio volumio[1022]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 17 09:08:30 volumio sudo[15677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-17 09:07 Feb 17 09:08:30 volumio sudo[15677]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="8bcc10c3dbcbcb349e9887dc0527d54876b32688" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 17 Nov 2025 09:24:57 PM CET" VOLUMIO_VERSION="3.875" VOLUMIO_HARDWARE="orangepione" VOLUMIO_DEVICENAME="Orange Pi One" VOLUMIO_HASH="f3e0bae0941c902026304db81d0165c2"