Oct 16 16:37:01 volumio-3b systemd[1]: Starting setdatetime-helper.service - Time Synchronization Helper Service... Oct 16 16:37:04 volumio-3b systemd[1]: setdatetime-helper.service: Deactivated successfully. Oct 16 16:37:04 volumio-3b systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Oct 16 16:37:04 volumio-3b systemd[1]: setdatetime-helper.service: Consumed 1.977s CPU time. Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPlay Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreStateMachine::play index undefined Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 16:37:25 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreStateMachine::startPlaybackTimer Oct 16 16:37:25 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:37:25 volumio-3b volumio[2513]: info: ControllerMpd::resume Oct 16 16:37:25 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand play Oct 16 16:37:25 volumio-3b volumio[2513]: info: Oct 16 16:37:25 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:37:25 volumio-3b volumio[2513]: info: sendMpdCommand play took 76 milliseconds Oct 16 16:37:25 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:37:25 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:37:25 volumio-3b volumio[2513]: info: sendMpdCommand status took 4 milliseconds Oct 16 16:37:25 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:37:25 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:37:25 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 16:37:25 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:37:25 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:37:25 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:37:25 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":10138,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"BEYOND - 无尽空虚.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无尽空虚.dff","trackType":"dff"} Oct 16 16:37:25 volumio-3b volumio[2513]: verbose: CURRENT POSITION 4 Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService play Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus pause Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:37:25 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:25 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:25 volumio-3b volumio[2513]: info: ------------------------------ 46ms Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPause Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreStateMachine::pause Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreStateMachine::stPlaybackTimer Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreStateMachine::servicePause Oct 16 16:37:33 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePause Oct 16 16:37:33 volumio-3b volumio[2513]: info: ControllerMpd::pause Oct 16 16:37:33 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand pause Oct 16 16:37:33 volumio-3b volumio[2513]: info: Oct 16 16:37:33 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:37:33 volumio-3b volumio[2513]: info: sendMpdCommand pause took 6 milliseconds Oct 16 16:37:33 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:37:33 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:37:33 volumio-3b volumio[2513]: info: sendMpdCommand status took 2 milliseconds Oct 16 16:37:33 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:37:33 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:37:33 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 16:37:33 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:37:33 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:37:33 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:37:33 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":18798,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"BEYOND - 无尽空虚.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无尽空虚.dff","trackType":"dff"} Oct 16 16:37:33 volumio-3b volumio[2513]: verbose: CURRENT POSITION 4 Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService pause Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus pause Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:37:33 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:37:33 volumio-3b volumio[2513]: info: CoreStateMachine::stPlaybackTimer Oct 16 16:37:33 volumio-3b volumio[2513]: info: ------------------------------ 35ms Oct 16 16:37:39 volumio-3b ntpd[926]: PROTO: 193.182.111.14 unlink local addr 192.168.4.24 -> Oct 16 16:37:49 volumio-3b kernel: hwmon hwmon1: Voltage normalised Oct 16 16:37:52 volumio-3b kernel: hwmon hwmon1: Undervoltage detected! Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPlay Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreStateMachine::play index undefined Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 16:38:04 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreStateMachine::startPlaybackTimer Oct 16 16:38:04 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:04 volumio-3b volumio[2513]: info: ControllerMpd::resume Oct 16 16:38:04 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand play Oct 16 16:38:04 volumio-3b volumio[2513]: info: Oct 16 16:38:04 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:04 volumio-3b volumio[2513]: info: sendMpdCommand play took 47 milliseconds Oct 16 16:38:04 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:04 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:04 volumio-3b volumio[2513]: info: sendMpdCommand status took 2 milliseconds Oct 16 16:38:04 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:04 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:04 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 16:38:04 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:04 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:04 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:04 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":18815,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"BEYOND - 无尽空虚.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无尽空虚.dff","trackType":"dff"} Oct 16 16:38:04 volumio-3b volumio[2513]: verbose: CURRENT POSITION 4 Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService play Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus pause Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:04 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:04 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:04 volumio-3b volumio[2513]: info: ------------------------------ 38ms Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPause Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreStateMachine::pause Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreStateMachine::stPlaybackTimer Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreStateMachine::servicePause Oct 16 16:38:09 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePause Oct 16 16:38:09 volumio-3b volumio[2513]: info: ControllerMpd::pause Oct 16 16:38:09 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand pause Oct 16 16:38:09 volumio-3b volumio[2513]: info: Oct 16 16:38:09 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:09 volumio-3b volumio[2513]: info: sendMpdCommand pause took 3 milliseconds Oct 16 16:38:09 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:09 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:09 volumio-3b volumio[2513]: info: sendMpdCommand status took 2 milliseconds Oct 16 16:38:09 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:09 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:09 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 16:38:09 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:09 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:09 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:09 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":23693,"duration":272,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"5644 Kbps","isStreaming":false,"title":"BEYOND - 无尽空虚.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无尽空虚.dff","trackType":"dff"} Oct 16 16:38:09 volumio-3b volumio[2513]: verbose: CURRENT POSITION 4 Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService pause Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus pause Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:09 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:09 volumio-3b volumio[2513]: info: CoreStateMachine::stPlaybackTimer Oct 16 16:38:09 volumio-3b volumio[2513]: info: ------------------------------ 35ms Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioNext Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::next Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::stop Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::updateTrackBlock Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrackBlock Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::stPlaybackTimer Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::serviceStop Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 4 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::serviceStop Oct 16 16:38:10 volumio-3b volumio[2513]: info: ControllerMpd::stop Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 16:38:10 volumio-3b volumio[2513]: info: Oct 16 16:38:10 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand stop took 18 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::play index undefined Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::startPlaybackTimer Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::clearAddPlayTracks USB/HIKSEMI/Shared Music/BEYOND - 无悔这一生.dff Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::updateTrackBlock Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrackBlock Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand status took 6 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand stop took 3 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 16:38:10 volumio-3b volumio[2513]: info: Oct 16 16:38:10 volumio-3b volumio[2513]: ---------------------------- MPD announces system playlist update Oct 16 16:38:10 volumio-3b volumio[2513]: info: Ignoring MPD Status Update Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand clear took 6 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand add "USB/HIKSEMI/Shared Music/BEYOND - 无悔这一生.dff" Oct 16 16:38:10 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: 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":"BEYOND - 无尽空虚.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无尽空虚.dff","trackType":"dff"} Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: CURRENT POSITION 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService stop Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus stop Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: No code Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: ------------------------------ 87ms Oct 16 16:38:10 volumio-3b volumio[2513]: error: updateQueue error: null Oct 16 16:38:10 volumio-3b volumio[2513]: info: Oct 16 16:38:10 volumio-3b volumio[2513]: ---------------------------- MPD announces system playlist update Oct 16 16:38:10 volumio-3b volumio[2513]: info: Ignoring MPD Status Update Oct 16 16:38:10 volumio-3b volumio[2513]: info: ------------------------------ 79ms Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand add "USB/HIKSEMI/Shared Music/BEYOND - 无悔这一生.dff" took 76 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand play Oct 16 16:38:10 volumio-3b volumio[2513]: info: ------------------------------ 21ms Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand play took 19 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: info: Oct 16 16:38:10 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:10 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:10 volumio-3b volumio[2513]: info: Oct 16 16:38:10 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand status took 46 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand status took 3 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:10 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BEYOND - 无悔这一生.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无悔这一生.dff","trackType":"dff"} Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: CURRENT POSITION 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService play Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus stop Oct 16 16:38:10 volumio-3b volumio[2513]: info: ------------------------------ 58ms Oct 16 16:38:10 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:10 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":240,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BEYOND - 无悔这一生.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无悔这一生.dff","trackType":"dff"} Oct 16 16:38:10 volumio-3b volumio[2513]: verbose: CURRENT POSITION 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService play Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus play Oct 16 16:38:10 volumio-3b volumio[2513]: info: Received an update from plugin. extracting info from payload Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:10 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:10 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:11 volumio-3b volumio[2513]: info: ------------------------------ 56ms Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioNext Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::next Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::stop Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::stPlaybackTimer Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::updateTrackBlock Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrackBlock Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::serviceStop Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 5 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::serviceStop Oct 16 16:38:14 volumio-3b volumio[2513]: info: ControllerMpd::stop Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 16:38:14 volumio-3b volumio[2513]: info: Oct 16 16:38:14 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand stop took 22 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::play index undefined Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::startPlaybackTimer Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::clearAddPlayTracks USB/HIKSEMI/Shared Music/BEYOND - 灰色轨迹.dff Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::updateTrackBlock Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrackBlock Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand status took 7 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand stop took 4 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 16:38:14 volumio-3b volumio[2513]: info: Oct 16 16:38:14 volumio-3b volumio[2513]: ---------------------------- MPD announces system playlist update Oct 16 16:38:14 volumio-3b volumio[2513]: info: Ignoring MPD Status Update Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 5 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand clear took 4 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand add "USB/HIKSEMI/Shared Music/BEYOND - 灰色轨迹.dff" Oct 16 16:38:14 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: 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":"BEYOND - 无悔这一生.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 无悔这一生.dff","trackType":"dff"} Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: CURRENT POSITION 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService stop Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus stop Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: No code Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: ------------------------------ 96ms Oct 16 16:38:14 volumio-3b volumio[2513]: error: updateQueue error: null Oct 16 16:38:14 volumio-3b volumio[2513]: info: Oct 16 16:38:14 volumio-3b volumio[2513]: ---------------------------- MPD announces system playlist update Oct 16 16:38:14 volumio-3b volumio[2513]: info: Ignoring MPD Status Update Oct 16 16:38:14 volumio-3b volumio[2513]: info: ------------------------------ 86ms Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand add "USB/HIKSEMI/Shared Music/BEYOND - 灰色轨迹.dff" took 83 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand play Oct 16 16:38:14 volumio-3b volumio[2513]: info: ------------------------------ 34ms Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand play took 32 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: info: Oct 16 16:38:14 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:14 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:14 volumio-3b volumio[2513]: info: Oct 16 16:38:14 volumio-3b volumio[2513]: ---------------------------- MPD announces state update: player Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand status took 46 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: info: ControllerMpd::getState Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand status Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand status took 2 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::parseState Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:14 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":326,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BEYOND - 灰色轨迹.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 灰色轨迹.dff","trackType":"dff"} Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: CURRENT POSITION 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService play Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus stop Oct 16 16:38:14 volumio-3b volumio[2513]: info: ------------------------------ 56ms Oct 16 16:38:14 volumio-3b volumio[2513]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: ControllerMpd::parseTrackInfo Oct 16 16:38:14 volumio-3b volumio[2513]: info: ControllerMpd::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::servicePushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":326,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"BEYOND - 灰色轨迹.dff","artist":null,"album":null,"uri":"USB/HIKSEMI/Shared Music/BEYOND - 灰色轨迹.dff","trackType":"dff"} Oct 16 16:38:14 volumio-3b volumio[2513]: verbose: CURRENT POSITION 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::syncState stateService play Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::syncState currentStatus play Oct 16 16:38:14 volumio-3b volumio[2513]: info: Received an update from plugin. extracting info from payload Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreStateMachine::pushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:14 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioPushState Oct 16 16:38:14 volumio-3b volumio[2513]: info: ------------------------------ 64ms Oct 16 16:38:18 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioGetState Oct 16 16:38:18 volumio-3b volumio[2513]: info: CorePlayQueue::getTrack 6 Oct 16 16:38:19 volumio-3b volumio[2513]: info: CoreCommandRouter::volumioGetQueue Oct 16 16:38:19 volumio-3b volumio[2513]: info: CoreStateMachine::getQueue Oct 16 16:38:19 volumio-3b volumio[2513]: info: CorePlayQueue::getQueue Oct 16 16:38:19 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Beyond/BEYOND%20IV/edde96fc-ef4d-4c91-aef2-3da2b98959ee.jpg' Oct 16 16:38:19 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jacky%20Cheung/Bu%20Lao%20Di%20Chuan%20Shuo/e6eb3d23-1ce9-43cc-b7b9-4d07a43ceca7.jpg' Oct 16 16:38:19 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jacky%20Cheung/Shi%20Fang%20Zi%20Ji/f4ed357a-fef2-453e-8306-e13713646c5b.jpg' Oct 16 16:38:19 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jeff%20Chang/The%20Essential%20Jeff%20Chang/61a02449-6960-4483-95c4-7a063a8fa993.jpg' Oct 16 16:38:20 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%BA%8C%E6%89%8B%E7%8E%AB%E7%91%B0%E4%B9%90%E9%98%9F/%E4%B8%80%E6%9E%9D%E7%8B%AC%E7%A7%80/871c7dde-81f2-457d-9c02-a6b00293f815.jpg' Oct 16 16:38:20 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%8E%8B%E6%9D%B0/%E4%B8%8D%E5%AD%A4%E5%8D%95/3d7dee3c-8c48-416b-9610-0b4dbe958eba.jpg' Oct 16 16:38:20 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E4%BC%A0%E5%A5%87%20-%20%E6%88%91%E4%B8%8E%E4%BD%A0/1fa071d8-20be-453b-b8b8-982b46ea2e2b.jpg' Oct 16 16:38:20 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E9%98%BF%E5%86%97/%E4%BD%A0%E7%9A%84%E7%AD%94%E6%A1%88/c63a12ca-2eb2-44eb-a8c8-ca5ee12c75c2.jpg' Oct 16 16:38:20 volumio-3b volumio[2513]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9E%97%E5%BF%86%E8%8E%B2/%E6%9C%80%E5%A5%BD%E7%9A%84%E6%9E%97%E5%BF%86%E8%8E%B22003%E7%B2%BE%E9%80%89/fb9f033d-6be7-454a-b11d-983004edeea8.jpg' Oct 16 16:38:21 volumio-3b volumio[2513]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:38:21 volumio-3b volumio[2513]: Error: connect ECONNREFUSED 202.160.129.36:443 Oct 16 16:38:21 volumio-3b volumio[2513]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) { Oct 16 16:38:21 volumio-3b volumio[2513]: errno: -111, Oct 16 16:38:21 volumio-3b volumio[2513]: code: 'ECONNREFUSED', Oct 16 16:38:21 volumio-3b volumio[2513]: syscall: 'connect', Oct 16 16:38:21 volumio-3b volumio[2513]: address: '202.160.129.36', Oct 16 16:38:21 volumio-3b volumio[2513]: port: 443 Oct 16 16:38:21 volumio-3b volumio[2513]: } Oct 16 16:38:21 volumio-3b volumio[2513]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 16:38:22 volumio-3b sudo[7492]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-10-16 16:37' Oct 16 16:38:22 volumio-3b sudo[7492]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"