-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Tue 2026-03-24 17:28:59 CST. -- Mar 24 17:27:05 volumio volumio[722]: info: Preload queue cleared Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::ClearQueue Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::stop Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::updateTrackBlock Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrackBlock Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 0 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::serviceStop Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 0 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::serviceStop Mar 24 17:27:05 volumio volumio[722]: info: [1774344425741] ControllerUPNPBrowser::stop Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::clearPlayQueue Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::saveQueue Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::addQueueItems Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::addQueueItems Mar 24 17:27:05 volumio volumio[722]: info: Preload queue cleared Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$3 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$3 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$0 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$0 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::saveQueue Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::updateTrackBlock Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrackBlock Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPlay Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::play index 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::addQueueItems Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::addQueueItems Mar 24 17:27:05 volumio volumio[722]: info: Preload queue cleared Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$1 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$1 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$2 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$2 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$4 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$4 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$5 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$5 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$6 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$6 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$7 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$7 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$8 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$8 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$9 Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$9 Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$A Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$A Mar 24 17:27:05 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$B Mar 24 17:27:05 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$B Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::stop Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::saveQueue Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::play index undefined Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::updateTrackBlock Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrackBlock Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::startPlaybackTimer Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: [1774344425790] ControllerUPNPBrowser::clearAddPlayTrack Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand stop took 56 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand stop took 7 milliseconds Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand clear Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:05 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 7 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand clear took 6 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 4 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 3 milliseconds Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.72:8200/MediaItems/219.flac" Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: 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} Mar 24 17:27:05 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState stateService stop Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: No code Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: 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} Mar 24 17:27:05 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState stateService stop Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: No code Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 68ms Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 69ms Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:05 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:05 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:05 volumio volumio[722]: error: updateQueue error: null Mar 24 17:27:05 volumio volumio[722]: error: updateQueue error: null Mar 24 17:27:05 volumio volumio[722]: error: updateQueue error: null Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 76ms Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand playlistinfo took 73 milliseconds Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.72:8200/MediaItems/219.flac" Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 7ms Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 6ms Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:05 volumio volumio[722]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 85ms Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:05 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand add "http://192.168.31.72:8200/MediaItems/219.flac" took 11 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand play Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:05 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:05 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 5ms Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand play took 4 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 3ms Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 2ms Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 8 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 10 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 8 milliseconds Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 12 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"219.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:05 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"219.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:05 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:05 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"219.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:05 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:05 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 43ms Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 67ms Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 66ms Mar 24 17:27:05 volumio volumio[722]: info: Mar 24 17:27:05 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:05 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 53 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand status took 51 milliseconds Mar 24 17:27:05 volumio volumio[722]: info: sendMpdCommand playlistinfo took 49 milliseconds Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:05 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:05 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:05 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:05 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"219.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:05 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:05 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:05 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:05 volumio volumio[722]: info: ------------------------------ 87ms Mar 24 17:27:06 volumio volumio[722]: info: Mar 24 17:27:06 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:06 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:06 volumio volumio[722]: info: Mar 24 17:27:06 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:06 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:06 volumio volumio[722]: info: Mar 24 17:27:06 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 36ms Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand playlistinfo took 33 milliseconds Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand playlistinfo took 36 milliseconds Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 8ms Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 7ms Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:06 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相思","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:06 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:06 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:06 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相思","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:06 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:06 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 133ms Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 132ms Mar 24 17:27:06 volumio volumio[722]: info: Mar 24 17:27:06 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:06 volumio volumio[722]: info: Mar 24 17:27:06 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand status took 57 milliseconds Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand status took 11 milliseconds Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand status took 11 milliseconds Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand playlistinfo took 24 milliseconds Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 24 17:27:06 volumio volumio[722]: info: sendMpdCommand playlistinfo took 23 milliseconds Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:06 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:06 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2650 Kbps","isStreaming":false,"title":"相思","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:06 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:06 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:06 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2650 Kbps","isStreaming":false,"title":"相思","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:06 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:06 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:06 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":228,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2650 Kbps","isStreaming":false,"title":"相思","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/219.flac","trackType":"flac"} Mar 24 17:27:06 volumio volumio[722]: verbose: CURRENT POSITION 1 Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:06 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 601ms Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 556ms Mar 24 17:27:06 volumio volumio[722]: info: ------------------------------ 554ms Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:06 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:06 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:22 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:23 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:23 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:24 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:25 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:26 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:27 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:28 volumio volumio[722]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AF%9B%E9%98%BF%E6%95%8F/%E5%A4%A9%E4%B9%8B%E5%A4%A7/73c0cd82-ba41-425f-b400-7e363d2d6bb6.jpg' Mar 24 17:27:30 volumio volumio[722]: info: Preload queue cleared Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::ClearQueue Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::stop Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::updateTrackBlock Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrackBlock Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::serviceStop Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 1 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::serviceStop Mar 24 17:27:30 volumio volumio[722]: info: [1774344450659] ControllerUPNPBrowser::stop Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::clearPlayQueue Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::saveQueue Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::addQueueItems Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::addQueueItems Mar 24 17:27:30 volumio volumio[722]: info: Preload queue cleared Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$3 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$3 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$0 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$0 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$1 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$1 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$2 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$2 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$4 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$4 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$5 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$5 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$6 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$6 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$7 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$7 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$8 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$8 Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$9 Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$9 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::saveQueue Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::updateTrackBlock Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrackBlock Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPlay Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::play index 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::addQueueItems Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::addQueueItems Mar 24 17:27:30 volumio volumio[722]: info: Preload queue cleared Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$A Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$A Mar 24 17:27:30 volumio volumio[722]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$B Mar 24 17:27:30 volumio volumio[722]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$0$A$B Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::stop Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushQueue Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::saveQueue Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::play index undefined Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::updateTrackBlock Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrackBlock Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::startPlaybackTimer Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: [1774344450711] ControllerUPNPBrowser::clearAddPlayTrack Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand stop Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand stop took 61 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand stop took 12 milliseconds Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand clear Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 6 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand clear took 5 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 4 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 3 milliseconds Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.72:8200/MediaItems/233.flac" Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: 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} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService stop Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: No code Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: 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} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService stop Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: No code Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 62ms Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 62ms Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: error: updateQueue error: null Mar 24 17:27:30 volumio volumio[722]: error: updateQueue error: null Mar 24 17:27:30 volumio volumio[722]: error: updateQueue error: null Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 70ms Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 67 milliseconds Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.72:8200/MediaItems/233.flac" Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 9ms Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 9ms Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 82ms Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand add "http://192.168.31.72:8200/MediaItems/233.flac" took 11 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand play Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 5ms Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand play took 7 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 5ms Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 4ms Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 8 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 4 milliseconds Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 7 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 4 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"233.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus stop Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"233.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:30 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 35ms Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 35ms Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 31 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"233.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:30 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"233.flac","artist":null,"album":null,"uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:30 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 79ms Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 79ms Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces system playlist update Mar 24 17:27:30 volumio volumio[722]: info: Ignoring MPD Status Update Mar 24 17:27:30 volumio volumio[722]: info: Mar 24 17:27:30 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 55 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 55ms Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 53 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 53 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 10ms Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 10 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 4ms Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:30 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ------------------------------ 109ms Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand status took 29 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 26 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 26 milliseconds Mar 24 17:27:30 volumio volumio[722]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":47,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:30 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":115,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1142 Kbps","isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:30 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:30 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:30 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":771,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2622 Kbps","isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:30 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:30 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:30 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:30 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:31 volumio volumio[722]: info: ------------------------------ 133ms Mar 24 17:27:31 volumio volumio[722]: info: ------------------------------ 132ms Mar 24 17:27:31 volumio volumio[722]: info: ------------------------------ 88ms Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: sendMpdCommand playlistinfo took 78 milliseconds Mar 24 17:27:31 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:27:31 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:27:31 volumio volumio[722]: verbose: STATE SERVICE {"status":"play","position":0,"seek":992,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2777 Kbps","isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:27:31 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::syncState stateService play Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus play Mar 24 17:27:31 volumio volumio[722]: info: Received an update from plugin. extracting info from payload Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:27:31 volumio volumio[722]: info: ------------------------------ 124ms Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:27:31 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:27:31 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::volumioPause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::pause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::servicePause Mar 24 17:28:11 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::servicePause Mar 24 17:28:11 volumio volumio[722]: info: [1774344491544] ControllerUPNPBrowser::pause Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand pause Mar 24 17:28:11 volumio volumio[722]: info: sendMpdCommand pause took 1 milliseconds Mar 24 17:28:11 volumio volumio[722]: info: Mar 24 17:28:11 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:28:11 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:28:11 volumio volumio[722]: info: Mar 24 17:28:11 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:28:11 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:28:11 volumio volumio[722]: info: Mar 24 17:28:11 volumio volumio[722]: ---------------------------- MPD announces state update: player Mar 24 17:28:11 volumio volumio[722]: info: ControllerMpd::getState Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand status Mar 24 17:28:11 volumio volumio[722]: info: sendMpdCommand status took 5 milliseconds Mar 24 17:28:11 volumio volumio[722]: info: sendMpdCommand status took 3 milliseconds Mar 24 17:28:11 volumio volumio[722]: info: sendMpdCommand status took 2 milliseconds Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::parseState Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 24 17:28:11 volumio volumio[722]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 24 17:28:11 volumio volumio[722]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 24 17:28:11 volumio volumio[722]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:28:11 volumio volumio[722]: verbose: ControllerMpd::parseTrackInfo Mar 24 17:28:11 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:28:11 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:28:11 volumio volumio[722]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41616,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2772 Kbps","isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:28:11 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::syncState stateService pause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus pause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:28:11 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:28:11 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:28:11 volumio volumio[722]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41616,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2772 Kbps","isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:28:11 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::syncState stateService pause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus pause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:28:11 volumio volumio[722]: info: ControllerMpd::pushState Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::servicePushState Mar 24 17:28:11 volumio volumio[722]: info: CorePlayQueue::getTrack 9 Mar 24 17:28:11 volumio volumio[722]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41616,"duration":293,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2772 Kbps","isStreaming":false,"title":"天之大","artist":"毛阿敏","album":"天之大","uri":"http://192.168.31.72:8200/MediaItems/233.flac","trackType":"flac"} Mar 24 17:28:11 volumio volumio[722]: verbose: CURRENT POSITION 9 Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::syncState stateService pause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::syncState currentStatus pause Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::pushState Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::volumioPushState Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::stPlaybackTimer Mar 24 17:28:11 volumio volumio[722]: info: ------------------------------ 52ms Mar 24 17:28:11 volumio volumio[722]: info: ------------------------------ 51ms Mar 24 17:28:11 volumio volumio[722]: info: ------------------------------ 50ms Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:28:11 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:28:11 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:28:11 volumio volumio[722]: info: CoreCommandRouter::volumioGetQueue Mar 24 17:28:11 volumio volumio[722]: info: CoreStateMachine::getQueue Mar 24 17:28:11 volumio volumio[722]: info: CorePlayQueue::getQueue Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 24 17:28:17 volumio volumio[722]: info: Getting Alsa Cards List without I2S DAC Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Mar 24 17:28:17 volumio volumio[722]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 24 17:28:31 volumio ntpd[655]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 24 17:28:59 volumio volumio[722]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 17:28:59 volumio volumio[722]: Error: connect ETIMEDOUT 69.171.247.71:443 Mar 24 17:28:59 volumio volumio[722]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 24 17:28:59 volumio volumio[722]: errno: -110, Mar 24 17:28:59 volumio volumio[722]: code: 'ETIMEDOUT', Mar 24 17:28:59 volumio volumio[722]: syscall: 'connect', Mar 24 17:28:59 volumio volumio[722]: address: '69.171.247.71', Mar 24 17:28:59 volumio volumio[722]: port: 443 Mar 24 17:28:59 volumio volumio[722]: } Mar 24 17:28:59 volumio volumio[722]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 17:28:59 volumio sudo[2422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-24 17:27 Mar 24 17:28:59 volumio sudo[2422]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="464fc672d77d3df6ee72b331d36cdf1fa936e1ec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 27 Feb 2026 10:59:40 AM CET" VOLUMIO_VERSION="3.912" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="37c6ab864cb114e1344d540995c69f86"