-- Logs begin at Thu 2025-02-27 08:42:08 UTC, end at Thu 2025-02-27 09:52:38 UTC. -- Feb 27 09:51:01 volumio volumio[16943]: info: Preload queue cleared Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::ClearQueue Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::stPlaybackTimer Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::updateTrackBlock Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrackBlock Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::serviceStop Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::serviceStop Feb 27 09:51:01 volumio volumio[16943]: info: [1740649861063] ControllerUPNPBrowser::stop Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand stop Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::clearPlayQueue Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::saveQueue Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushQueue Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::addQueueItems Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::addQueueItems Feb 27 09:51:01 volumio volumio[16943]: info: Preload queue cleared Feb 27 09:51:01 volumio volumio[16943]: info: Adding Item to queue: upnp/folder/http://192.168.8.240:50001/ContentDirectory/control@22$5007 Feb 27 09:51:01 volumio volumio[16943]: info: Exploding uri upnp/folder/http://192.168.8.240:50001/ContentDirectory/control@22$5007 in service upnp_browser Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand stop took 29 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 2 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 11 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 8 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 7 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"13302.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13302.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: No code Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 62ms Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushQueue Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::saveQueue Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::updateTrackBlock Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrackBlock Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPlay Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::play index 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::play index undefined Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::startPlaybackTimer Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: [1740649861176] ControllerUPNPBrowser::clearAddPlayTrack Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand stop Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 71 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 71 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand stop took 7 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand clear Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"13302.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13302.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: No code Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"13302.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13302.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus stop Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: No code Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 140ms Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 138ms Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces system playlist update Feb 27 09:51:01 volumio volumio[16943]: info: Ignoring MPD Status Update Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand clear took 66 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand load "http://192.168.8.240:50002/m/NDLNA/13304.flac" Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces system playlist update Feb 27 09:51:01 volumio volumio[16943]: info: Ignoring MPD Status Update Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces system playlist update Feb 27 09:51:01 volumio volumio[16943]: info: Ignoring MPD Status Update Feb 27 09:51:01 volumio volumio[16943]: error: updateQueue error: null Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 6ms Feb 27 09:51:01 volumio volumio[16943]: error: updateQueue error: null Feb 27 09:51:01 volumio volumio[16943]: error: updateQueue error: null Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand add "http://192.168.8.240:50002/m/NDLNA/13304.flac" Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 83ms Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 83ms Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces system playlist update Feb 27 09:51:01 volumio volumio[16943]: info: Ignoring MPD Status Update Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand add "http://192.168.8.240:50002/m/NDLNA/13304.flac" took 2 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand play Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces system playlist update Feb 27 09:51:01 volumio volumio[16943]: info: Ignoring MPD Status Update Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces system playlist update Feb 27 09:51:01 volumio volumio[16943]: info: Ignoring MPD Status Update Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 6ms Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand play took 5 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 4ms Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 3ms Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 218 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 217 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 212 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"98 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus stop Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 231ms Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: Feb 27 09:51:01 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 12 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 10 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 9 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 5 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand status took 3 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"674 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:01 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"595 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:01 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 290ms Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 287ms Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 60 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 58 milliseconds Feb 27 09:51:01 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 59 milliseconds Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"619 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:01 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"619 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:01 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:01 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:01 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"619 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:01 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:01 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:01 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 156ms Feb 27 09:51:01 volumio volumio[16943]: info: ------------------------------ 151ms Feb 27 09:51:32 volumio volumio[16943]: info: CoreCommandRouter::volumioSeek Feb 27 09:51:32 volumio volumio[16943]: info: CoreStateMachine::seek Feb 27 09:51:32 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:32 volumio volumio[16943]: info: TRACKBLOCK {"service":"upnp_browser","uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","realUri":"upnp/folder/http://192.168.8.240:50001/ContentDirectory/control@22$5007","type":"song","albumart":"/albumart?cacheid=687&web=/%E6%B5%8B%E8%AF%95%E7%8E%8B%5BHI-FI%E7%95%8C%E4%BD%8E%E9%9F%B3%E7%8E%8B%E5%AD%90-%E8%B5%B5%E9%B9%8F%5D-3009/extralarge&path=&metadata=false","artist":"","album":"测试王[HI-FI界低音王子-赵鹏]-3009","name":"赵鹏.-.1900-01-01.-.测试王 HI-FI界低音王子.-.涂鸦文化","title":"赵鹏.-.1900-01-01.-.测试王 HI-FI界低音王子.-.涂鸦文化","duration":3021} Feb 27 09:51:32 volumio volumio[16943]: info: CoreStateMachine::startPlaybackTimer Feb 27 09:51:32 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:32 volumio volumio[16943]: info: [1740649892937] ControllerUPNPBrowser::seek Feb 27 09:51:32 volumio volumio[16943]: info: ControllerMpd::seek Feb 27 09:51:32 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:32 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:32 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:33 volumio volumio[16943]: error: null Feb 27 09:51:33 volumio volumio[16943]: info: Feb 27 09:51:33 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:33 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:33 volumio volumio[16943]: info: Feb 27 09:51:33 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:33 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:33 volumio volumio[16943]: info: Feb 27 09:51:33 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:33 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:33 volumio volumio[16943]: info: sendMpdCommand status took 11 milliseconds Feb 27 09:51:33 volumio volumio[16943]: info: sendMpdCommand status took 8 milliseconds Feb 27 09:51:33 volumio volumio[16943]: info: sendMpdCommand status took 4 milliseconds Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:33 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 27 09:51:33 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 7 milliseconds Feb 27 09:51:33 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 6 milliseconds Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:33 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:33 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:33 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:33 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":257842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"259 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:33 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:33 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:33 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:33 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:33 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":257842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"375 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:33 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:33 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:33 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:33 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:33 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":257842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"375 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:33 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:33 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:33 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:33 volumio volumio[16943]: info: ------------------------------ 127ms Feb 27 09:51:33 volumio volumio[16943]: info: ------------------------------ 124ms Feb 27 09:51:33 volumio volumio[16943]: info: ------------------------------ 119ms Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioSeek Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::seek Feb 27 09:51:46 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:46 volumio volumio[16943]: info: TRACKBLOCK {"service":"upnp_browser","uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","realUri":"upnp/folder/http://192.168.8.240:50001/ContentDirectory/control@22$5007","type":"song","albumart":"/albumart?cacheid=687&web=/%E6%B5%8B%E8%AF%95%E7%8E%8B%5BHI-FI%E7%95%8C%E4%BD%8E%E9%9F%B3%E7%8E%8B%E5%AD%90-%E8%B5%B5%E9%B9%8F%5D-3009/extralarge&path=&metadata=false","artist":"","album":"测试王[HI-FI界低音王子-赵鹏]-3009","name":"赵鹏.-.1900-01-01.-.测试王 HI-FI界低音王子.-.涂鸦文化","title":"赵鹏.-.1900-01-01.-.测试王 HI-FI界低音王子.-.涂鸦文化","duration":3021} Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::startPlaybackTimer Feb 27 09:51:46 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:46 volumio volumio[16943]: info: [1740649906402] ControllerUPNPBrowser::seek Feb 27 09:51:46 volumio volumio[16943]: info: ControllerMpd::seek Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:46 volumio volumio[16943]: error: null Feb 27 09:51:46 volumio volumio[16943]: info: Feb 27 09:51:46 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:46 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:46 volumio volumio[16943]: info: Feb 27 09:51:46 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:46 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:46 volumio volumio[16943]: info: Feb 27 09:51:46 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:46 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:46 volumio volumio[16943]: info: sendMpdCommand status took 5 milliseconds Feb 27 09:51:46 volumio volumio[16943]: info: sendMpdCommand status took 3 milliseconds Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:46 volumio volumio[16943]: info: sendMpdCommand status took 4 milliseconds Feb 27 09:51:46 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 3 milliseconds Feb 27 09:51:46 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 2 milliseconds Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:46 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:46 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:46 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":608000,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"817 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:46 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:46 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:46 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:46 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:46 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":608000,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"817 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:46 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:46 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:46 volumio volumio[16943]: info: ------------------------------ 61ms Feb 27 09:51:46 volumio volumio[16943]: info: ------------------------------ 59ms Feb 27 09:51:46 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 54 milliseconds Feb 27 09:51:46 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:46 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:46 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:46 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":608000,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"817 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:46 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:46 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:46 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:46 volumio volumio[16943]: info: ------------------------------ 86ms Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioSeek Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::seek Feb 27 09:51:49 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:49 volumio volumio[16943]: info: TRACKBLOCK {"service":"upnp_browser","uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","realUri":"upnp/folder/http://192.168.8.240:50001/ContentDirectory/control@22$5007","type":"song","albumart":"/albumart?cacheid=687&web=/%E6%B5%8B%E8%AF%95%E7%8E%8B%5BHI-FI%E7%95%8C%E4%BD%8E%E9%9F%B3%E7%8E%8B%E5%AD%90-%E8%B5%B5%E9%B9%8F%5D-3009/extralarge&path=&metadata=false","artist":"","album":"测试王[HI-FI界低音王子-赵鹏]-3009","name":"赵鹏.-.1900-01-01.-.测试王 HI-FI界低音王子.-.涂鸦文化","title":"赵鹏.-.1900-01-01.-.测试王 HI-FI界低音王子.-.涂鸦文化","duration":3021} Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::startPlaybackTimer Feb 27 09:51:49 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:49 volumio volumio[16943]: info: [1740649909495] ControllerUPNPBrowser::seek Feb 27 09:51:49 volumio volumio[16943]: info: ControllerMpd::seek Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:49 volumio volumio[16943]: error: null Feb 27 09:51:49 volumio volumio[16943]: info: Feb 27 09:51:49 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:49 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:49 volumio volumio[16943]: info: Feb 27 09:51:49 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:49 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:49 volumio volumio[16943]: info: Feb 27 09:51:49 volumio volumio[16943]: ---------------------------- MPD announces state update: player Feb 27 09:51:49 volumio volumio[16943]: info: ControllerMpd::getState Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand status Feb 27 09:51:49 volumio volumio[16943]: info: sendMpdCommand status took 11 milliseconds Feb 27 09:51:49 volumio volumio[16943]: info: sendMpdCommand status took 8 milliseconds Feb 27 09:51:49 volumio volumio[16943]: info: sendMpdCommand status took 4 milliseconds Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::parseState Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 27 09:51:49 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 27 09:51:49 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 5 milliseconds Feb 27 09:51:49 volumio volumio[16943]: info: sendMpdCommand playlistinfo took 4 milliseconds Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:49 volumio volumio[16943]: verbose: ControllerMpd::parseTrackInfo Feb 27 09:51:49 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:49 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:49 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1052000,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1018 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:49 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:49 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:49 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:49 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:49 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1052000,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1018 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:49 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:49 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:49 volumio volumio[16943]: info: ControllerMpd::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::servicePushState Feb 27 09:51:49 volumio volumio[16943]: info: CorePlayQueue::getTrack 0 Feb 27 09:51:49 volumio volumio[16943]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1052842,"duration":3021,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"981 Kbps","isStreaming":false,"title":"13304.flac","artist":null,"album":null,"uri":"http://192.168.8.240:50002/m/NDLNA/13304.flac","trackType":"flac"} Feb 27 09:51:49 volumio volumio[16943]: verbose: CURRENT POSITION 0 Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::syncState stateService play Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::syncState currentStatus play Feb 27 09:51:49 volumio volumio[16943]: info: Received an update from plugin. extracting info from payload Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreStateMachine::pushState Feb 27 09:51:49 volumio volumio[16943]: info: CoreCommandRouter::volumioPushState Feb 27 09:51:49 volumio volumio[16943]: info: ------------------------------ 137ms Feb 27 09:51:49 volumio volumio[16943]: info: ------------------------------ 131ms Feb 27 09:51:49 volumio volumio[16943]: info: ------------------------------ 129ms Feb 27 09:51:59 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 27 09:51:59 volumio volumio[16943]: info: Preload queue cleared Feb 27 09:51:59 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13309 Feb 27 09:51:59 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13309 in service upnp_browser Feb 27 09:52:03 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 27 09:52:03 volumio volumio[16943]: info: Preload queue cleared Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13276 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13253 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13279 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13263 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13296 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13267 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13293 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13272 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13243 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13273 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13280 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13260 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13249 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13265 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13247 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13281 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13266 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13261 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13283 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13244 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13250 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13268 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13242 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13252 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13295 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13289 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13290 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13287 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13292 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13270 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13286 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13269 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13246 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13294 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13277 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13248 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13291 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13264 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13284 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13262 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13278 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13257 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13285 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13271 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13255 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13254 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13282 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13251 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13256 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13258 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13245 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13274 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13275 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13288 Feb 27 09:52:03 volumio volumio[16943]: info: Preloading song: upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13259 Feb 27 09:52:03 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13276 in service upnp_browser Feb 27 09:52:03 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13253 in service upnp_browser Feb 27 09:52:03 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13279 in service upnp_browser Feb 27 09:52:03 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13263 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13296 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13267 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13293 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13272 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13243 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13273 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13280 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13260 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13249 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13265 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13247 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13281 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13266 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13261 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13283 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13244 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13250 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13268 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13242 in service upnp_browser Feb 27 09:52:04 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13252 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13295 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13289 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13290 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13287 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13292 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13270 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13286 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13269 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13246 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13294 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13277 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13248 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13291 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13264 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13284 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13262 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13278 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13257 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13285 in service upnp_browser Feb 27 09:52:05 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13271 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13255 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13254 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13282 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13251 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13256 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13258 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13245 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13274 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13275 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13288 in service upnp_browser Feb 27 09:52:06 volumio volumio[16943]: info: Exploding uri upnp/http://192.168.8.240:50001/ContentDirectory/control@22$@13259 in service upnp_browser Feb 27 09:52:14 volumio sudo[17509]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 27 09:52:14 volumio sudo[17509]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 27 09:52:14 volumio sudo[17509]: pam_unix(sudo:session): session closed for user root Feb 27 09:52:14 volumio sudo[17512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 27 09:52:14 volumio sudo[17512]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 27 09:52:14 volumio sudo[17512]: pam_unix(sudo:session): session closed for user root Feb 27 09:52:14 volumio volumio[16943]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.8 UA: Mozilla/5.0 (Linux; Android 12; HarmonyOS; ALN-AL00; HMSCore 6.15.0.302) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/114.0.5735.196 HuaweiBrowser/16.0.1.301 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::volumioGetVisibleSources Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::volumioGetState Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 27 09:52:14 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 27 09:52:14 volumio sudo[17517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 27 09:52:14 volumio sudo[17517]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 27 09:52:14 volumio sudo[17517]: pam_unix(sudo:session): session closed for user root Feb 27 09:52:14 volumio sudo[17519]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 27 09:52:14 volumio sudo[17519]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 27 09:52:14 volumio sudo[17519]: pam_unix(sudo:session): session closed for user root Feb 27 09:52:14 volumio volumio[16943]: verbose: New Socket.io Connection to 192.168.8.100 from 192.168.8.8 UA: Mozilla/5.0 (Linux; Android 12; HarmonyOS; ALN-AL00; HMSCore 6.15.0.302) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/114.0.5735.196 HuaweiBrowser/16.0.1.301 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Feb 27 09:52:15 volumio volumio[16943]: info: CoreCommandRouter::volumioGetState Feb 27 09:52:15 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 27 09:52:15 volumio volumio[16943]: info: Listing playlists Feb 27 09:52:15 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 27 09:52:15 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Feb 27 09:52:15 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Feb 27 09:52:15 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 27 09:52:19 volumio volumio[16943]: info: CoreCommandRouter::volumioGetQueue Feb 27 09:52:19 volumio volumio[16943]: info: CoreStateMachine::getQueue Feb 27 09:52:19 volumio volumio[16943]: info: CorePlayQueue::getQueue Feb 27 09:52:23 volumio volumio[16943]: info: CoreCommandRouter::volumioGetVisibleSources Feb 27 09:52:23 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 27 09:52:25 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 27 09:52:25 volumio volumio[16943]: info: CURURI: playlists Feb 27 09:52:25 volumio volumio[16943]: info: Listing playlists Feb 27 09:52:25 volumio volumio[16943]: info: Preload queue cleared Feb 27 09:52:29 volumio volumio[16943]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Feb 27 09:52:29 volumio volumio[16943]: info: CURURI: playlists/1 Feb 27 09:52:29 volumio volumio[16943]: info: Preload queue cleared Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/车厘子的车车 - 一生中最爱.flac Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/车厘子的车车 - 一生中最爱.flac Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/潘美辰 - 我曾用心爱着你.flac Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/钟明秋 - 梦里水乡.flac Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/陈佳 - 顺流逆流.ogg Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/陈佳 - 又见炊烟.ogg Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/陈佳 - 山茶花.ogg Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/彭筝 - 太想念.flac Feb 27 09:52:29 volumio volumio[16943]: info: Preloading song: mnt/USB/_¼Ӿ_/雷婷 - 你会爱我到什么时候.flac Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/车厘子的车车 - 一生中最爱.flac in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E8%BD%A6%E5%8E%98%E5%AD%90%E7%9A%84%E8%BD%A6%E8%BD%A6/%E4%B8%80%E7%94%9F%E4%B8%AD%E6%9C%80%E7%88%B1/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E8%BD%A6%E5%8E%98%E5%AD%90%E7%9A%84%E8%BD%A6%E8%BD%A6%20-%20%E4%B8%80%E7%94%9F%E4%B8%AD%E6%9C%80%E7%88%B1.flac&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/车厘子的车车 - 一生中最爱.flac Feb 27 09:52:30 volumio volumio[16943]: info: Using cached record of: mnt/USB/_¼Ӿ_/车厘子的车车 - 一生中最爱.flac Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/潘美辰 - 我曾用心爱着你.flac in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E6%BD%98%E7%BE%8E%E8%BE%B0/%E4%B8%8D%E8%A6%81%E8%B5%B0%E4%B8%8D%E8%A6%81%E8%B5%B0/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E6%BD%98%E7%BE%8E%E8%BE%B0%20-%20%E6%88%91%E6%9B%BE%E7%94%A8%E5%BF%83%E7%88%B1%E7%9D%80%E4%BD%A0.flac&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/潘美辰 - 我曾用心爱着你.flac Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/钟明秋 - 梦里水乡.flac in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E9%92%9F%E6%98%8E%E7%A7%8B/%E4%B8%BA%E4%BD%A0%E9%92%9F%E6%83%85/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E9%92%9F%E6%98%8E%E7%A7%8B%20-%20%E6%A2%A6%E9%87%8C%E6%B0%B4%E4%B9%A1.flac&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/钟明秋 - 梦里水乡.flac Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/陈佳 - 顺流逆流.ogg in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E9%99%88%E4%BD%B3/%E4%BC%BC%E6%98%AF%E6%95%85%E4%BA%BA%E6%9D%A5/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E9%99%88%E4%BD%B3%20-%20%E9%A1%BA%E6%B5%81%E9%80%86%E6%B5%81.ogg&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/陈佳 - 顺流逆流.ogg Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/陈佳 - 又见炊烟.ogg in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E9%99%88%E4%BD%B3/%E5%8F%88%E8%A7%81%E9%82%93%E4%B8%BD%E5%90%9B/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E9%99%88%E4%BD%B3%20-%20%E5%8F%88%E8%A7%81%E7%82%8A%E7%83%9F.ogg&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/陈佳 - 又见炊烟.ogg Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/陈佳 - 山茶花.ogg in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E9%99%88%E4%BD%B3/%E5%8F%88%E8%A7%81%E9%82%93%E4%B8%BD%E5%90%9B/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E9%99%88%E4%BD%B3%20-%20%E5%B1%B1%E8%8C%B6%E8%8A%B1.ogg&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/陈佳 - 山茶花.ogg Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/彭筝 - 太想念.flac in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E5%BD%AD%E7%AD%9D/%E5%A4%AA%E6%83%B3%E5%BF%B5/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E5%BD%AD%E7%AD%9D%20-%20%E5%A4%AA%E6%83%B3%E5%BF%B5.flac&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/彭筝 - 太想念.flac Feb 27 09:52:30 volumio volumio[16943]: info: Exploding uri mnt/USB/_¼Ӿ_/雷婷 - 你会爱我到什么时候.flac in service mpd Feb 27 09:52:30 volumio volumio[16943]: info: ALBUMART /albumart?cacheid=687&web=%E9%9B%B7%E5%A9%B7/%E5%AD%98%E5%9C%A8/extralarge&path=%2Fmnt%2FUSB%2F_%C2%BC%D3%BE_%2F%E9%9B%B7%E5%A9%B7%20-%20%E4%BD%A0%E4%BC%9A%E7%88%B1%E6%88%91%E5%88%B0%E4%BB%80%E4%B9%88%E6%97%B6%E5%80%99.flac&metadata=false Feb 27 09:52:30 volumio volumio[16943]: info: URI /mnt/USB/_¼Ӿ_/雷婷 - 你会爱我到什么时候.flac Feb 27 09:52:38 volumio volumio[16943]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 09:52:38 volumio volumio[16943]: Error: connect ETIMEDOUT 31.13.91.6:443 Feb 27 09:52:38 volumio volumio[16943]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Feb 27 09:52:38 volumio volumio[16943]: errno: -110, Feb 27 09:52:38 volumio volumio[16943]: code: 'ETIMEDOUT', Feb 27 09:52:38 volumio volumio[16943]: syscall: 'connect', Feb 27 09:52:38 volumio volumio[16943]: address: '31.13.91.6', Feb 27 09:52:38 volumio volumio[16943]: port: 443 Feb 27 09:52:38 volumio volumio[16943]: } Feb 27 09:52:38 volumio volumio[16943]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 27 09:52:38 volumio sudo[17617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-27 09:51 Feb 27 09:52:38 volumio sudo[17617]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"