-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Thu 2026-03-26 12:17:49 CST. -- Mar 26 12:16:08 volumio volumio[10491]: info: Preload queue cleared Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::ClearQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::stop Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::clearPlayQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::saveQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::addQueueItems Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::addQueueItems Mar 26 12:16:08 volumio volumio[10491]: info: Preload queue cleared Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$0 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$0 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$1 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$1 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$2 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$2 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$3 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$3 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$4 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$4 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$5 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$5 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$6 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$6 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$7 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$7 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$8 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$8 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$9 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$9 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$A Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$A Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$B Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$B Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$C Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$C Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::saveQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::updateTrackBlock Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrackBlock Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPlay Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::play index 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::addQueueItems Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::addQueueItems Mar 26 12:16:08 volumio volumio[10491]: info: Preload queue cleared Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$D Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$D Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$E Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$E Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$F Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$F Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$10 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$10 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$11 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$11 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$12 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$12 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$13 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$13 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$14 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$14 Mar 26 12:16:08 volumio volumio[10491]: info: Adding Item to queue: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$15 Mar 26 12:16:08 volumio volumio[10491]: info: Using cached record of: upnp/http://192.168.31.72:8200/ctl/ContentDir@64$6$14$15 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::stop Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::saveQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::play index undefined Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::updateTrackBlock Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrackBlock Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::startPlaybackTimer Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: info: [1774498568787] ControllerUPNPBrowser::clearAddPlayTrack Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand stop took 9 milliseconds Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces system playlist update Mar 26 12:16:08 volumio volumio[10491]: info: Ignoring MPD Status Update Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand clear took 1 milliseconds Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.31.72:8200/MediaItems/9760.flac" Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces system playlist update Mar 26 12:16:08 volumio volumio[10491]: info: Ignoring MPD Status Update Mar 26 12:16:08 volumio volumio[10491]: error: updateQueue error: null Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 3ms Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.31.72:8200/MediaItems/9760.flac" Mar 26 12:16:08 volumio volumio[10491]: error: updateQueue error: null Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces system playlist update Mar 26 12:16:08 volumio volumio[10491]: info: Ignoring MPD Status Update Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 14ms Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand add "http://192.168.31.72:8200/MediaItems/9760.flac" took 2 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand play Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces system playlist update Mar 26 12:16:08 volumio volumio[10491]: info: Ignoring MPD Status Update Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 4ms Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand play took 3 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 2ms Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces state update: player Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::getState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand status Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces state update: player Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::getState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand status Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces state update: player Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand status took 13 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand status took 11 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::getState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand status Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces state update: player Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::getState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand status Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces system playlist update Mar 26 12:16:08 volumio volumio[10491]: info: Ignoring MPD Status Update Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces state update: player Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::getState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand status Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand status took 8 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand status took 7 milliseconds Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseTrackInfo Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseTrackInfo Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::servicePushState Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"祈祷","artist":"王杰/王韵婵","album":"王杰/王韵婵","uri":"http://192.168.31.72:8200/MediaItems/9760.flac","trackType":"flac"} Mar 26 12:16:08 volumio volumio[10491]: verbose: CURRENT POSITION 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState stateService play Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState currentStatus stop Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::servicePushState Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"祈祷","artist":"王杰/王韵婵","album":"王杰/王韵婵","uri":"http://192.168.31.72:8200/MediaItems/9760.flac","trackType":"flac"} Mar 26 12:16:08 volumio volumio[10491]: verbose: CURRENT POSITION 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState stateService play Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState currentStatus play Mar 26 12:16:08 volumio volumio[10491]: info: Received an update from plugin. extracting info from payload Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 46ms Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 49ms Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces system playlist update Mar 26 12:16:08 volumio volumio[10491]: info: Ignoring MPD Status Update Mar 26 12:16:08 volumio volumio[10491]: info: Mar 26 12:16:08 volumio volumio[10491]: ---------------------------- MPD announces state update: player Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::getState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand status Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 34ms Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand status took 32 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand playlistinfo took 30 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand playlistinfo took 28 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 5ms Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseTrackInfo Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::servicePushState Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"442 Kbps","isStreaming":false,"title":"祈祷","artist":"王杰/王韵婵","album":"王杰/王韵婵","uri":"http://192.168.31.72:8200/MediaItems/9760.flac","trackType":"flac"} Mar 26 12:16:08 volumio volumio[10491]: verbose: CURRENT POSITION 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState stateService play Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState currentStatus play Mar 26 12:16:08 volumio volumio[10491]: info: Received an update from plugin. extracting info from payload Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::servicePushState Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"569 Kbps","isStreaming":false,"title":"祈祷","artist":"王杰/王韵婵","album":"王杰/王韵婵","uri":"http://192.168.31.72:8200/MediaItems/9760.flac","trackType":"flac"} Mar 26 12:16:08 volumio volumio[10491]: verbose: CURRENT POSITION 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState stateService play Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState currentStatus play Mar 26 12:16:08 volumio volumio[10491]: info: Received an update from plugin. extracting info from payload Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 68ms Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 61ms Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand status took 80 milliseconds Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand playlistinfo took 75 milliseconds Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseState Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseTrackInfo Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::servicePushState Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"630 Kbps","isStreaming":false,"title":"祈祷","artist":"王杰/王韵婵","album":"王杰/王韵婵","uri":"http://192.168.31.72:8200/MediaItems/9760.flac","trackType":"flac"} Mar 26 12:16:08 volumio volumio[10491]: verbose: CURRENT POSITION 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState stateService play Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState currentStatus play Mar 26 12:16:08 volumio volumio[10491]: info: Received an update from plugin. extracting info from payload Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 122ms Mar 26 12:16:08 volumio volumio[10491]: info: sendMpdCommand playlistinfo took 12 milliseconds Mar 26 12:16:08 volumio volumio[10491]: verbose: ControllerMpd::parseTrackInfo Mar 26 12:16:08 volumio volumio[10491]: info: ControllerMpd::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::servicePushState Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getTrack 12 Mar 26 12:16:08 volumio volumio[10491]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":238,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"625 Kbps","isStreaming":false,"title":"祈祷","artist":"王杰/王韵婵","album":"王杰/王韵婵","uri":"http://192.168.31.72:8200/MediaItems/9760.flac","trackType":"flac"} Mar 26 12:16:08 volumio volumio[10491]: verbose: CURRENT POSITION 12 Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState stateService play Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::syncState currentStatus play Mar 26 12:16:08 volumio volumio[10491]: info: Received an update from plugin. extracting info from payload Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::pushState Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioPushState Mar 26 12:16:08 volumio volumio[10491]: info: ------------------------------ 104ms Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreCommandRouter::volumioGetQueue Mar 26 12:16:08 volumio volumio[10491]: info: CoreStateMachine::getQueue Mar 26 12:16:08 volumio volumio[10491]: info: CorePlayQueue::getQueue Mar 26 12:17:06 volumio nmbd[678]: [2026/03/26 12:17:06.004152, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Mar 26 12:17:06 volumio nmbd[678]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.31.19 for name WORKGROUP<1d>. Mar 26 12:17:06 volumio nmbd[678]: This response was from IP 192.168.31.1, reporting an IP address of 192.168.31.1. Mar 26 12:17:49 volumio volumio[10491]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 12:17:49 volumio volumio[10491]: Error: connect ETIMEDOUT 104.244.43.234:443 Mar 26 12:17:49 volumio volumio[10491]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 26 12:17:49 volumio volumio[10491]: errno: -110, Mar 26 12:17:49 volumio volumio[10491]: code: 'ETIMEDOUT', Mar 26 12:17:49 volumio volumio[10491]: syscall: 'connect', Mar 26 12:17:49 volumio volumio[10491]: address: '104.244.43.234', Mar 26 12:17:49 volumio volumio[10491]: port: 443 Mar 26 12:17:49 volumio volumio[10491]: } Mar 26 12:17:49 volumio volumio[10491]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 12:17:49 volumio sudo[7353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-03-26 12:16 Mar 26 12:17:49 volumio sudo[7353]: 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"